Jobsub ID 242409.6@dunegpschedd01.fnal.gov

Jobsub ID	242409.6@dunegpschedd01.fnal.gov
Workflow ID	9554
Stage ID	1
User name	epennacc@fnal.gov
Requested	Processors	1
	GPU	No
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2025-11-03 16:05:02
Site	US_UChicago
Entry	Engage_US_MWT2_iut2_condce_mcore
Last heartbeat	2025-11-03 17:09:47
From worker node	Hostname	iut2-c282.iu.edu
	cpuinfo	Intel(R) Xeon(R) Gold 6148 CPU @ 2.40GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	86400 (24 hours)
	GPU
	Inner Apptainer?	True
Job state	finished
Started	2025-11-03 16:11:43
Input files	fardet-hd:prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171033Z_gen_002281_supernova_g4_detsim.root fardet-hd:prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171109Z_gen_002345_supernova_g4_detsim.root fardet-hd:prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165551Z_gen_001325_supernova_g4_detsim.root fardet-hd:prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163509Z_gen_000520_supernova_g4_detsim.root fardet-hd:prodmarley_nue_flat_es_dune10kt_1x2x2_20250927T061509Z_gen_000071_supernova_g4_detsim.root
Jobscript	Exit code	0
	Real time	45m (2755s)
	CPU time	39m (2370s = 86%)
	Max RSS bytes	801472512 (764 MiB)
Outputting started	2025-11-03 16:57:38
Output files	usertests:prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165551Z_gen_001325_supernova_g4_detsim_20251103T163131Z_reco.root usertests:prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171109Z_gen_002345_supernova_g4_detsim_20251103T162231Z_reco.root usertests:prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171033Z_gen_002281_supernova_g4_detsim_20251103T161201Z_reco.root usertests:prodmarley_nue_flat_es_dune10kt_1x2x2_20250927T061509Z_gen_000071_supernova_g4_detsim_20251103T164910Z_reco.root usertests:prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163509Z_gen_000520_supernova_g4_detsim_20251103T164018Z_reco.root
Finished	2025-11-03 17:09:47
Saved logs	justin-logs:242409.6-dunegpschedd01.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

_20251103T164910Z_reco.root"
Begin processing the 2nd record. run: 8145 subRun: 0 event: 3502 at 03-Nov-2025 11:50:17 EST
Begin processing the 3rd record. run: 8145 subRun: 0 event: 3503 at 03-Nov-2025 11:50:26 EST
Begin processing the 4th record. run: 8145 subRun: 0 event: 3504 at 03-Nov-2025 11:50:35 EST
Begin processing the 5th record. run: 8145 subRun: 0 event: 3505 at 03-Nov-2025 11:50:45 EST
Begin processing the 6th record. run: 8145 subRun: 0 event: 3506 at 03-Nov-2025 11:50:54 EST
Begin processing the 7th record. run: 8145 subRun: 0 event: 3507 at 03-Nov-2025 11:51:03 EST
Begin processing the 8th record. run: 8145 subRun: 0 event: 3508 at 03-Nov-2025 11:51:12 EST
Begin processing the 9th record. run: 8145 subRun: 0 event: 3509 at 03-Nov-2025 11:51:21 EST
Begin processing the 10th record. run: 8145 subRun: 0 event: 3510 at 03-Nov-2025 11:51:29 EST
Begin processing the 11th record. run: 8145 subRun: 0 event: 3511 at 03-Nov-2025 11:51:39 EST
Begin processing the 12th record. run: 8145 subRun: 0 event: 3512 at 03-Nov-2025 11:51:48 EST
Begin processing the 13th record. run: 8145 subRun: 0 event: 3513 at 03-Nov-2025 11:51:57 EST
Begin processing the 14th record. run: 8145 subRun: 0 event: 3514 at 03-Nov-2025 11:52:05 EST
Begin processing the 15th record. run: 8145 subRun: 0 event: 3515 at 03-Nov-2025 11:52:14 EST
Begin processing the 16th record. run: 8145 subRun: 0 event: 3516 at 03-Nov-2025 11:52:22 EST
Begin processing the 17th record. run: 8145 subRun: 0 event: 3517 at 03-Nov-2025 11:52:32 EST
Begin processing the 18th record. run: 8145 subRun: 0 event: 3518 at 03-Nov-2025 11:52:41 EST
Begin processing the 19th record. run: 8145 subRun: 0 event: 3519 at 03-Nov-2025 11:52:51 EST
Begin processing the 20th record. run: 8145 subRun: 0 event: 3520 at 03-Nov-2025 11:53:00 EST
Begin processing the 21st record. run: 8145 subRun: 0 event: 3521 at 03-Nov-2025 11:53:09 EST
Begin processing the 22nd record. run: 8145 subRun: 0 event: 3522 at 03-Nov-2025 11:53:18 EST
Begin processing the 23rd record. run: 8145 subRun: 0 event: 3523 at 03-Nov-2025 11:53:27 EST
Begin processing the 24th record. run: 8145 subRun: 0 event: 3524 at 03-Nov-2025 11:53:36 EST
Begin processing the 25th record. run: 8145 subRun: 0 event: 3525 at 03-Nov-2025 11:53:45 EST
Begin processing the 26th record. run: 8145 subRun: 0 event: 3526 at 03-Nov-2025 11:53:53 EST
Begin processing the 27th record. run: 8145 subRun: 0 event: 3527 at 03-Nov-2025 11:54:03 EST
Begin processing the 28th record. run: 8145 subRun: 0 event: 3528 at 03-Nov-2025 11:54:11 EST
Begin processing the 29th record. run: 8145 subRun: 0 event: 3529 at 03-Nov-2025 11:54:20 EST
Begin processing the 30th record. run: 8145 subRun: 0 event: 3530 at 03-Nov-2025 11:54:30 EST
Begin processing the 31st record. run: 8145 subRun: 0 event: 3531 at 03-Nov-2025 11:54:40 EST
Begin processing the 32nd record. run: 8145 subRun: 0 event: 3532 at 03-Nov-2025 11:54:49 EST
Begin processing the 33rd record. run: 8145 subRun: 0 event: 3533 at 03-Nov-2025 11:54:57 EST
Begin processing the 34th record. run: 8145 subRun: 0 event: 3534 at 03-Nov-2025 11:55:05 EST
Begin processing the 35th record. run: 8145 subRun: 0 event: 3535 at 03-Nov-2025 11:55:14 EST
Begin processing the 36th record. run: 8145 subRun: 0 event: 3536 at 03-Nov-2025 11:55:22 EST
Begin processing the 37th record. run: 8145 subRun: 0 event: 3537 at 03-Nov-2025 11:55:32 EST
Begin processing the 38th record. run: 8145 subRun: 0 event: 3538 at 03-Nov-2025 11:55:42 EST
Begin processing the 39th record. run: 8145 subRun: 0 event: 3539 at 03-Nov-2025 11:55:50 EST
Begin processing the 40th record. run: 8145 subRun: 0 event: 3540 at 03-Nov-2025 11:55:59 EST
Begin processing the 41st record. run: 8145 subRun: 0 event: 3541 at 03-Nov-2025 11:56:06 EST
Begin processing the 42nd record. run: 8145 subRun: 0 event: 3542 at 03-Nov-2025 11:56:14 EST
Begin processing the 43rd record. run: 8145 subRun: 0 event: 3543 at 03-Nov-2025 11:56:22 EST
Begin processing the 44th record. run: 8145 subRun: 0 event: 3544 at 03-Nov-2025 11:56:30 EST
Begin processing the 45th record. run: 8145 subRun: 0 event: 3545 at 03-Nov-2025 11:56:39 EST
Begin processing the 46th record. run: 8145 subRun: 0 event: 3546 at 03-Nov-2025 11:56:47 EST
Begin processing the 47th record. run: 8145 subRun: 0 event: 3547 at 03-Nov-2025 11:56:55 EST
Begin processing the 48th record. run: 8145 subRun: 0 event: 3548 at 03-Nov-2025 11:57:03 EST
Begin processing the 49th record. run: 8145 subRun: 0 event: 3549 at 03-Nov-2025 11:57:13 EST
Begin processing the 50th record. run: 8145 subRun: 0 event: 3550 at 03-Nov-2025 11:57:23 EST
03-Nov-2025 11:57:34 EST  Closed output file "prodmarley_nue_flat_es_dune10kt_1x2x2_20250927T061509Z_gen_000071_supernova_g4_detsim_20251103T164910Z_reco.root"
03-Nov-2025 11:57:34 EST  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/ba/c1/prodmarley_nue_flat_es_dune10kt_1x2x2_20250927T061509Z_gen_000071_supernova_g4_detsim.root"

=========================================================================================================================================
TimeTracker printout (sec)                                 Min           Avg           Max         Median          RMS         nEvts   
=========================================================================================================================================
Full event                                               7.40487       8.77135       10.513        8.65753      0.638076        50     
-----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                 0.000333803   0.00129219    0.00716329     0.000568     0.00182347       50     
makers:tpmakerTPCsimpleThr:TriggerPrimitiveMakerTPC      3.7815        4.65643       5.5578        4.6203       0.386347        50     
makers:tpmakerTPCabsRS:TriggerPrimitiveMakerTPC          3.61844       4.10932       5.16871       4.0282       0.351784        50     
[art]:TriggerResults:TriggerResultInserter             2.4896e-05    5.55032e-05   0.000235149   5.15525e-05   3.1107e-05       50     
end_path:out1:RootOutput                                3.644e-06    9.15086e-06   3.8114e-05     8.947e-06    4.78303e-06      50     
end_path:out1:RootOutput(write)                        0.00193327    0.00344284    0.00638797    0.00302456    0.000992239      50     
=========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 1535.16 MB
  Peak resident set size usage (VmHWM): 801.473 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Moving on to metadata extractor 
mv: cannot stat 'triggerAnaTree_hist.root': No such file or directory
============OUTPUT FILE:  prodmarley_nue_flat_es_dune10kt_1x2x2_20250927T061509Z_gen_000071_supernova_g4_detsim_20251103T164910Z_reco.root
Extracted metadata
checking file====== fardet-hd:prodmarley_nue_flat_es_dune10kt_1x2x2_20250927T061509Z_gen_000071_supernova_g4_detsim.root
MD conversion to MetaCat OK
all-input-dids.txt
debugprod.log
did.list
file.list
jobscript.log
mem.db
old_md.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163509Z_gen_000520_supernova_g4_detsim_20251103T164018Z_reco.root
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163509Z_gen_000520_supernova_g4_detsim_20251103T164018Z_reco.root.ext.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163509Z_gen_000520_supernova_g4_detsim_20251103T164018Z_reco.root.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163509Z_gen_000520_supernova_g4_detsim_20251103T164018Z_reco.root.temp.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165551Z_gen_001325_supernova_g4_detsim_20251103T163131Z_reco.root
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165551Z_gen_001325_supernova_g4_detsim_20251103T163131Z_reco.root.ext.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165551Z_gen_001325_supernova_g4_detsim_20251103T163131Z_reco.root.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165551Z_gen_001325_supernova_g4_detsim_20251103T163131Z_reco.root.temp.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171033Z_gen_002281_supernova_g4_detsim_20251103T161201Z_reco.root
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171033Z_gen_002281_supernova_g4_detsim_20251103T161201Z_reco.root.ext.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171033Z_gen_002281_supernova_g4_detsim_20251103T161201Z_reco.root.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171033Z_gen_002281_supernova_g4_detsim_20251103T161201Z_reco.root.temp.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171109Z_gen_002345_supernova_g4_detsim_20251103T162231Z_reco.root
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171109Z_gen_002345_supernova_g4_detsim_20251103T162231Z_reco.root.ext.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171109Z_gen_002345_supernova_g4_detsim_20251103T162231Z_reco.root.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T171109Z_gen_002345_supernova_g4_detsim_20251103T162231Z_reco.root.temp.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250927T061509Z_gen_000071_supernova_g4_detsim_20251103T164910Z_reco.root
prodmarley_nue_flat_es_dune10kt_1x2x2_20250927T061509Z_gen_000071_supernova_g4_detsim_20251103T164910Z_reco.root.ext.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250927T061509Z_gen_000071_supernova_g4_detsim_20251103T164910Z_reco.root.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250927T061509Z_gen_000071_supernova_g4_detsim_20251103T164910Z_reco.root.temp.json
temp_pfns.txt
time.db
triggersim_hist.root