justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 203774.165@justin-prod-sched02.dune.hep.ac.uk

Jobsub ID203774.165@justin-prod-sched02.dune.hep.ac.uk
Workflow ID6951
Stage ID1
User namecalcuttj@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes8387559424 (7999 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2025-05-14 03:31:17
SiteUS_FNAL-FermiGrid
EntryFNAL_GPGrid_ce03_mcore_op_duneonly
Last heartbeat2025-05-14 07:46:13
From worker nodeHostnamedunegli-4996164-0-fnpc22013.fnal.gov
cpuinfoAMD EPYC 7543 32-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes8387559424 (7999 MiB)
Wall seconds limit172800 (48 hours)
GPU
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2025-05-14 05:25:15
Input filesmonte-carlo-006951-002055
JobscriptExit code0
Real time2h (8422s)
CPU time2h (8260s = 98%)
Max RSS bytes20599308288 (19645 MiB)
Outputting started2025-05-14 07:45:38
Output filesusertests:extracted_wires_r00001_s00000_20250514T052520Z_203774_165_1.h5
Finished2025-05-14 07:46:13
Saved logsjustin-logs:203774.165-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

wclsFrameSaver: saving 110541 traces tagged "wiener"
FrameSaver: q=3.1045e+06 n=1218807 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 94937 traces, 94937 summary
Retagger: tagging trace set: gauss with 77203 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 77203 traces tagged "gauss"
FrameSaver: q=2.30692e+06 n=1177841 tag=gauss
wclsFrameSaver: saving 94937 traces tagged "wiener"
FrameSaver: q=2.55985e+06 n=1078268 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 84015 traces, 84015 summary
Retagger: tagging trace set: gauss with 69232 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 69232 traces tagged "gauss"
FrameSaver: q=1.85882e+06 n=964303 tag=gauss
wclsFrameSaver: saving 84015 traces tagged "wiener"
FrameSaver: q=2.11825e+06 n=894809 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 74240 traces, 74240 summary
Retagger: tagging trace set: gauss with 63998 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 63998 traces tagged "gauss"
FrameSaver: q=1.3952e+06 n=868604 tag=gauss
wclsFrameSaver: saving 74240 traces tagged "wiener"
FrameSaver: q=1.58258e+06 n=808076 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 79019 traces, 79019 summary
Retagger: tagging trace set: gauss with 65408 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 65408 traces tagged "gauss"
FrameSaver: q=1.71591e+06 n=925955 tag=gauss
wclsFrameSaver: saving 79019 traces tagged "wiener"
FrameSaver: q=1.95511e+06 n=871027 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 72844 traces, 72844 summary
Retagger: tagging trace set: gauss with 62781 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 62781 traces tagged "gauss"
FrameSaver: q=1.64213e+06 n=927526 tag=gauss
wclsFrameSaver: saving 72844 traces tagged "wiener"
FrameSaver: q=1.81515e+06 n=865889 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 80161 traces, 80161 summary
Retagger: tagging trace set: gauss with 63260 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 63260 traces tagged "gauss"
FrameSaver: q=1.73271e+06 n=868983 tag=gauss
wclsFrameSaver: saving 80161 traces tagged "wiener"
FrameSaver: q=1.97889e+06 n=810581 tag=wiener
14-May-2025 07:44:36 UTC  Closed output file "placeholder_1_203774_165_1747200326_stage1_stage2_stage3_stage4_stage5_stage6.root"
14-May-2025 07:44:36 UTC  Closed input file "placeholder_1_203774_165_1747200326_stage1_stage2_stage3_stage4_stage5.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      28.4857       29.495        30.3536       29.522       0.492317        10     
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000332488   0.00100813    0.00137742     0.0011307    0.000323635      10     
simulate:wclsnfspbadapa1:WireCellToolkit        28.323        29.2908       30.096        29.3378      0.465614        10     
[art]:TriggerResults:TriggerResultInserter    2.2232e-05    3.39704e-05   9.3277e-05    2.71515e-05   2.00315e-05      10     
end_path:out1:RootOutput                       4.418e-06    9.3395e-06    2.5518e-05     8.271e-06    5.67842e-06      10     
end_path:out1:RootOutput(write)                0.161104      0.201476      0.254881      0.186947      0.0319351       10     
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5229.34 MB
  Peak resident set size usage (VmHWM): 3619.09 MB
  Details saved in: 'mem.db'
====================================================================================================

{'art_out': 'placeholder_1_203774_165_1747200326_stage1_stage2_stage3_stage4_stage5_stage6.root'}
extract
Running extract
['lar', '-c', 'run_extract_wire.fcl', 'placeholder_1_203774_165_1747200326_stage1_stage2_stage3_stage4_stage5_stage6.root', '-n', '-1']
Stdout:
Begin processing the 1st record. run: 1 subRun: 0 event: 1 at 14-May-2025 07:44:56 UTC
Begin processing the 2nd record. run: 1 subRun: 0 event: 2 at 14-May-2025 07:45:01 UTC
Begin processing the 3rd record. run: 1 subRun: 0 event: 3 at 14-May-2025 07:45:05 UTC
Begin processing the 4th record. run: 1 subRun: 0 event: 4 at 14-May-2025 07:45:09 UTC
Begin processing the 5th record. run: 1 subRun: 0 event: 5 at 14-May-2025 07:45:14 UTC
Begin processing the 6th record. run: 1 subRun: 0 event: 6 at 14-May-2025 07:45:18 UTC
Begin processing the 7th record. run: 1 subRun: 0 event: 7 at 14-May-2025 07:45:23 UTC
Begin processing the 8th record. run: 1 subRun: 0 event: 8 at 14-May-2025 07:45:26 UTC
Begin processing the 9th record. run: 1 subRun: 0 event: 9 at 14-May-2025 07:45:30 UTC
Begin processing the 10th record. run: 1 subRun: 0 event: 10 at 14-May-2025 07:45:33 UTC
Art has completed and will exit with status 0.

Stderr:
Info in <TGeoManager::Import>: Reading geometry from file: /cvmfs/dune.opensciencegrid.org/products/dune/dunecore/v10_01_03d00/gdml/protodunehd_v6_refactored.gdml
Info in <TGeoManager::TGeoManager>: Geometry GDMLImport, Geometry imported from GDML created
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 = 1148
Info in <TGeoManager::CloseGeometry>: 25608 nodes/ 5535 volume UID's in Geometry imported from GDML
Info in <TGeoManager::CloseGeometry>: ----------------modeler ready----------------
registering to  primaryGeneratorActionsMap_
registering to   eventActionsMap_
registering to   trackingActionsMap_
registering to  steppingActionsMap_
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).
14-May-2025 07:44:55 UTC  Initiating request to open input file "placeholder_1_203774_165_1747200326_stage1_stage2_stage3_stage4_stage5_stage6.root"
14-May-2025 07:44:56 UTC  Opened input file "placeholder_1_203774_165_1747200326_stage1_stage2_stage3_stage4_stage5_stage6.root"
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
initializeNtuple() called with cflag_=6
14-May-2025 07:45:37 UTC  Closed input file "placeholder_1_203774_165_1747200326_stage1_stage2_stage3_stage4_stage5_stage6.root"

======================================================================================================================
TimeTracker printout (sec)              Min           Avg           Max         Median          RMS         nEvts   
======================================================================================================================
Full event                            1.61451       2.11883       3.19431       1.97759      0.471236        10     
----------------------------------------------------------------------------------------------------------------------
source:RootInput(read)              0.00029108    0.00126194    0.00242639    0.00122033    0.000637287      10     
end_path:extractwire:ExtractWire      1.61176       2.11719       3.19297       1.97603      0.471483        10     
======================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 3465.24 MB
  Peak resident set size usage (VmHWM): 2611.58 MB
  Details saved in: 'mem.db'
====================================================================================================

{'art_out': 'placeholder_1_203774_165_1747200326_stage1_stage2_stage3_stage4_stage5_stage6_extract.root', 'start_time': 1747208677.403445, 'end_time': 1747208738.096726}
extracted_wires_r00001_s00000.h5
justIN time: 2025-05-27 20:10:29 UTC       justIN version: 01.03.01