Jobsub ID 40007.30@dunegpschedd01.fnal.gov

Jobsub ID	40007.30@dunegpschedd01.fnal.gov
Workflow ID	1980
Stage ID	1
User name	hsouza@fnal.gov
HTCondor Group	group_dune
Requested	Processors	1
	GPU	No
	RSS bytes	3145728000 (3000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2025-09-04 06:17:51
Site	NL_NIKHEF
Entry	VIRGO_NL_NIKHEF_klomp
Last heartbeat	2025-09-04 06:23:27
From worker node	Hostname	wn-choc-007.farm.nikhef.nl
	cpuinfo	Intel(R) Xeon(R) CPU E5-2650 v4 @ 2.20GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	3145728000 (3000 MiB)
	Wall seconds limit	129600 (36 hours)
	GPU
	Inner Apptainer?	True
Job state	outputting_failed
Started	2025-09-04 06:19:16
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6491894_500_20231208T005343Z_gen_g4_detsim_hitreco__20240510T031004Z_reco2.root
Jobscript	Exit code	0
	Real time	2m (165s)
	CPU time	0m (57s = 34%)
	Max RSS bytes	1259147264 (1200 MiB)
Outputting started	2025-09-04 06:22:02
Output files
Finished	2025-09-04 06:23:27
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

ord. run: 6491894 subRun: 1 event: 50030 at 04-Sep-2025 08:20:13 CEST
Begin processing the 31st record. run: 6491894 subRun: 1 event: 50031 at 04-Sep-2025 08:20:14 CEST
Begin processing the 32nd record. run: 6491894 subRun: 1 event: 50032 at 04-Sep-2025 08:20:15 CEST
Begin processing the 33rd record. run: 6491894 subRun: 1 event: 50033 at 04-Sep-2025 08:20:18 CEST
Begin processing the 34th record. run: 6491894 subRun: 1 event: 50034 at 04-Sep-2025 08:20:19 CEST
Begin processing the 35th record. run: 6491894 subRun: 1 event: 50035 at 04-Sep-2025 08:20:21 CEST
Begin processing the 36th record. run: 6491894 subRun: 1 event: 50036 at 04-Sep-2025 08:20:21 CEST
Begin processing the 37th record. run: 6491894 subRun: 1 event: 50037 at 04-Sep-2025 08:20:22 CEST
Begin processing the 38th record. run: 6491894 subRun: 1 event: 50038 at 04-Sep-2025 08:20:24 CEST
Begin processing the 39th record. run: 6491894 subRun: 1 event: 50039 at 04-Sep-2025 08:20:25 CEST
Begin processing the 40th record. run: 6491894 subRun: 1 event: 50040 at 04-Sep-2025 08:20:27 CEST
Begin processing the 41st record. run: 6491894 subRun: 1 event: 50041 at 04-Sep-2025 08:20:27 CEST
Begin processing the 42nd record. run: 6491894 subRun: 1 event: 50042 at 04-Sep-2025 08:20:28 CEST
Begin processing the 43rd record. run: 6491894 subRun: 1 event: 50043 at 04-Sep-2025 08:20:30 CEST
Begin processing the 44th record. run: 6491894 subRun: 1 event: 50044 at 04-Sep-2025 08:20:31 CEST
Begin processing the 45th record. run: 6491894 subRun: 1 event: 50045 at 04-Sep-2025 08:20:32 CEST
Begin processing the 46th record. run: 6491894 subRun: 1 event: 50046 at 04-Sep-2025 08:20:33 CEST
Begin processing the 47th record. run: 6491894 subRun: 1 event: 50047 at 04-Sep-2025 08:20:35 CEST
Begin processing the 48th record. run: 6491894 subRun: 1 event: 50048 at 04-Sep-2025 08:20:36 CEST
Begin processing the 49th record. run: 6491894 subRun: 1 event: 50049 at 04-Sep-2025 08:20:36 CEST
Begin processing the 50th record. run: 6491894 subRun: 1 event: 50050 at 04-Sep-2025 08:20:37 CEST
Begin processing the 51st record. run: 6491894 subRun: 1 event: 50051 at 04-Sep-2025 08:20:38 CEST
Begin processing the 52nd record. run: 6491894 subRun: 1 event: 50052 at 04-Sep-2025 08:20:39 CEST
Begin processing the 53rd record. run: 6491894 subRun: 1 event: 50053 at 04-Sep-2025 08:20:40 CEST
Begin processing the 54th record. run: 6491894 subRun: 1 event: 50054 at 04-Sep-2025 08:20:42 CEST
Begin processing the 55th record. run: 6491894 subRun: 1 event: 50055 at 04-Sep-2025 08:20:43 CEST
Begin processing the 56th record. run: 6491894 subRun: 1 event: 50056 at 04-Sep-2025 08:20:44 CEST
Begin processing the 57th record. run: 6491894 subRun: 1 event: 50057 at 04-Sep-2025 08:20:45 CEST
Begin processing the 58th record. run: 6491894 subRun: 1 event: 50058 at 04-Sep-2025 08:20:46 CEST
Begin processing the 59th record. run: 6491894 subRun: 1 event: 50059 at 04-Sep-2025 08:20:47 CEST
Begin processing the 60th record. run: 6491894 subRun: 1 event: 50060 at 04-Sep-2025 08:20:48 CEST
Begin processing the 61st record. run: 6491894 subRun: 1 event: 50061 at 04-Sep-2025 08:20:51 CEST
Begin processing the 62nd record. run: 6491894 subRun: 1 event: 50062 at 04-Sep-2025 08:20:52 CEST
Begin processing the 63rd record. run: 6491894 subRun: 1 event: 50063 at 04-Sep-2025 08:20:54 CEST
Begin processing the 64th record. run: 6491894 subRun: 1 event: 50064 at 04-Sep-2025 08:20:55 CEST
Begin processing the 65th record. run: 6491894 subRun: 1 event: 50065 at 04-Sep-2025 08:20:56 CEST
Begin processing the 66th record. run: 6491894 subRun: 1 event: 50066 at 04-Sep-2025 08:20:57 CEST
Begin processing the 67th record. run: 6491894 subRun: 1 event: 50067 at 04-Sep-2025 08:20:59 CEST
Begin processing the 68th record. run: 6491894 subRun: 1 event: 50068 at 04-Sep-2025 08:21:00 CEST
Begin processing the 69th record. run: 6491894 subRun: 1 event: 50069 at 04-Sep-2025 08:21:01 CEST
Begin processing the 70th record. run: 6491894 subRun: 1 event: 50070 at 04-Sep-2025 08:21:02 CEST
Begin processing the 71st record. run: 6491894 subRun: 1 event: 50071 at 04-Sep-2025 08:21:05 CEST
Begin processing the 72nd record. run: 6491894 subRun: 1 event: 50072 at 04-Sep-2025 08:21:06 CEST
Begin processing the 73rd record. run: 6491894 subRun: 1 event: 50073 at 04-Sep-2025 08:21:08 CEST
Begin processing the 74th record. run: 6491894 subRun: 1 event: 50074 at 04-Sep-2025 08:21:09 CEST
Begin processing the 75th record. run: 6491894 subRun: 1 event: 50075 at 04-Sep-2025 08:21:10 CEST
Begin processing the 76th record. run: 6491894 subRun: 1 event: 50076 at 04-Sep-2025 08:21:11 CEST
Begin processing the 77th record. run: 6491894 subRun: 1 event: 50077 at 04-Sep-2025 08:21:12 CEST
Begin processing the 78th record. run: 6491894 subRun: 1 event: 50078 at 04-Sep-2025 08:21:13 CEST
Begin processing the 79th record. run: 6491894 subRun: 1 event: 50079 at 04-Sep-2025 08:21:15 CEST
Begin processing the 80th record. run: 6491894 subRun: 1 event: 50080 at 04-Sep-2025 08:21:17 CEST
Begin processing the 81st record. run: 6491894 subRun: 1 event: 50081 at 04-Sep-2025 08:21:18 CEST
Begin processing the 82nd record. run: 6491894 subRun: 1 event: 50082 at 04-Sep-2025 08:21:19 CEST
Begin processing the 83rd record. run: 6491894 subRun: 1 event: 50083 at 04-Sep-2025 08:21:26 CEST
Begin processing the 84th record. run: 6491894 subRun: 1 event: 50084 at 04-Sep-2025 08:21:34 CEST
Begin processing the 85th record. run: 6491894 subRun: 1 event: 50085 at 04-Sep-2025 08:21:35 CEST
Begin processing the 86th record. run: 6491894 subRun: 1 event: 50086 at 04-Sep-2025 08:21:36 CEST
Begin processing the 87th record. run: 6491894 subRun: 1 event: 50087 at 04-Sep-2025 08:21:37 CEST
Begin processing the 88th record. run: 6491894 subRun: 1 event: 50088 at 04-Sep-2025 08:21:39 CEST
Begin processing the 89th record. run: 6491894 subRun: 1 event: 50089 at 04-Sep-2025 08:21:40 CEST
Begin processing the 90th record. run: 6491894 subRun: 1 event: 50090 at 04-Sep-2025 08:21:40 CEST
Begin processing the 91st record. run: 6491894 subRun: 1 event: 50091 at 04-Sep-2025 08:21:42 CEST
Begin processing the 92nd record. run: 6491894 subRun: 1 event: 50092 at 04-Sep-2025 08:21:43 CEST
Begin processing the 93rd record. run: 6491894 subRun: 1 event: 50093 at 04-Sep-2025 08:21:44 CEST
Begin processing the 94th record. run: 6491894 subRun: 1 event: 50094 at 04-Sep-2025 08:21:46 CEST
Begin processing the 95th record. run: 6491894 subRun: 1 event: 50095 at 04-Sep-2025 08:21:47 CEST
Begin processing the 96th record. run: 6491894 subRun: 1 event: 50096 at 04-Sep-2025 08:21:48 CEST
Begin processing the 97th record. run: 6491894 subRun: 1 event: 50097 at 04-Sep-2025 08:21:57 CEST
Begin processing the 98th record. run: 6491894 subRun: 1 event: 50098 at 04-Sep-2025 08:21:58 CEST
Begin processing the 99th record. run: 6491894 subRun: 1 event: 50099 at 04-Sep-2025 08:21:59 CEST
Begin processing the 100th record. run: 6491894 subRun: 1 event: 50100 at 04-Sep-2025 08:22:01 CEST
04-Sep-2025 08:22:01 CEST  Closed input file "root://se1.farm.particle.cz:1094//dune/RSE/fardet-hd/5e/84/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6491894_500_20231208T005343Z_gen_g4_detsim_hitreco__20240510T031004Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.290362       1.15049       7.81325      0.948447       1.03179        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0143907     0.0325066     0.0652594     0.0313038     0.0104917       100    
prod:pandorapid:Chi2ParticleID                 0.0844507     0.140451      0.238918      0.145359      0.0283897       100    
prod:energyreconue:EnergyReco                  0.153501      0.338635      0.848205      0.313877      0.107573        100    
prod:energyreconumu:EnergyReco                0.00168427     0.194036       5.11582      0.0692108     0.626019        100    
prod:energyreconc:EnergyReco                   0.0035016     0.0428997     0.480433      0.0288882     0.0715288       100    
[art]:TriggerResults:TriggerResultInserter    1.3003e-05    1.56725e-05   7.2672e-05    1.4862e-05    5.93689e-06      100    
end_path:ana:PIDASelectionAna                  0.0177555     0.401538       2.14906      0.352874      0.296264        100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5659.06 MB
  Peak resident set size usage (VmHWM): 1259.15 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
.:
total 56
-rw-r--r--. 1 dune012 dune 19921 Sep  4 08:22 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6491894_500_20231208T005343Z_gen_g4_detsim_hitreco__20240510T031004Z_reco2_pida_2025-09-04T_061920Z.root
-rw-r--r--. 1 dune012 dune 14218 Sep  4 08:22 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6491894_500_20231208T005343Z_gen_g4_detsim_hitreco__20240510T031004Z_reco2_reco_2025-09-04T_061920Z.log
-rw-r--r--. 1 dune012 dune 11972 Sep  4 08:22 jobscript.log
-rw-r--r--. 1 dune012 dune   186 Sep  4 08:22 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune   137 Sep  4 08:19 all-input-dids.txt
-rw-r--r--. 1 dune012 dune     0 Sep  4 08:19 debugprod.log