Jobsub ID 401876.33@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 401876.33@justin-prod-sched01.dune.hep.ac.uk |
| Workflow ID | 7106 |
| Stage ID | 1 |
| User name | calcuttj@fnal.gov |
| HTCondor Group | group_dune |
| Requested | Processors | 1 |
| GPU | No |
| RSS bytes | 8387559424 (7999 MiB) |
| Wall seconds limit | 80000 (22 hours) |
| Submitted time | 2025-05-22 10:27:23 |
| Site | CA_SFU |
| Entry | DUNE_CA_SFU_lcg-ce3 |
| Last heartbeat | 2025-05-22 12:30:17 |
| From worker node | Hostname | cdr541.int.cedar.computecanada.ca |
| cpuinfo | Intel(R) Xeon(R) CPU E5-2683 v4 @ 2.10GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 8387559424 (7999 MiB) |
| Wall seconds limit | 84598 (23 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk |
| Started | 2025-05-22 10:41:00 |
| Input files | monte-carlo-007106-006311
|
| Jobscript | Exit code | 0 |
| Real time | 1h (6502s) |
| CPU time | 1h (6438s = 99%) |
| Max RSS bytes | 11702640640 (11160 MiB) |
| Outputting started | 2025-05-22 12:29:23 |
| Output files | usertests:extracted_wires_r401876_s00033_20250522T104103Z_401876_33_1.h5
|
| Finished | 2025-05-22 12:30:17 |
| Saved logs | justin-logs:401876.33-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
| List job events Wrapper job log |
Jobscript log (last 10,000 characters)
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).
Inputer: "wclsRawFrameSource"
Outputer: "wclsFrameSaver:spsaver"
wclsFrameSaver: promising to produce recob::Wires named "gauss"
wclsFrameSaver: promising to produce recob::Wires named "wiener"
22-May-2025 05:22:59 PDT Initiating request to open input file "placeholder_1_401876_33_1747910467_stage1_stage2_stage3_stage4_stage5.root"
22-May-2025 05:23:00 PDT Opened input file "placeholder_1_401876_33_1747910467_stage1_stage2_stage3_stage4_stage5.root"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 84791 traces, 84791 summary
Retagger: tagging trace set: gauss with 70176 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 70176 traces tagged "gauss"
FrameSaver: q=1.721e+06 n=978110 tag=gauss
wclsFrameSaver: saving 84791 traces tagged "wiener"
FrameSaver: q=1.97677e+06 n=898341 tag=wiener
22-May-2025 05:23:57 PDT Opened output file with pattern "placeholder_1_401876_33_1747910467_stage1_stage2_stage3_stage4_stage5_stage6.root"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 85646 traces, 85646 summary
Retagger: tagging trace set: gauss with 71791 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 71791 traces tagged "gauss"
FrameSaver: q=1.91066e+06 n=1036435 tag=gauss
wclsFrameSaver: saving 85646 traces tagged "wiener"
FrameSaver: q=2.11817e+06 n=949087 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 93893 traces, 93893 summary
Retagger: tagging trace set: gauss with 76891 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 76891 traces tagged "gauss"
FrameSaver: q=2.07437e+06 n=1161689 tag=gauss
wclsFrameSaver: saving 93893 traces tagged "wiener"
FrameSaver: q=2.31286e+06 n=1073522 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 102991 traces, 102991 summary
Retagger: tagging trace set: gauss with 82211 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 82211 traces tagged "gauss"
FrameSaver: q=2.37085e+06 n=1220759 tag=gauss
wclsFrameSaver: saving 102991 traces tagged "wiener"
FrameSaver: q=2.64479e+06 n=1105772 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 66794 traces, 66794 summary
Retagger: tagging trace set: gauss with 53740 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 53740 traces tagged "gauss"
FrameSaver: q=1.13768e+06 n=625785 tag=gauss
wclsFrameSaver: saving 66794 traces tagged "wiener"
FrameSaver: q=1.37933e+06 n=611629 tag=wiener
22-May-2025 05:28:02 PDT Closed output file "placeholder_1_401876_33_1747910467_stage1_stage2_stage3_stage4_stage5_stage6.root"
22-May-2025 05:28:02 PDT Closed input file "placeholder_1_401876_33_1747910467_stage1_stage2_stage3_stage4_stage5.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 53.1691 54.3688 56.1548 53.5969 1.30483 5
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000444482 0.000775169 0.000987201 0.00087949 0.000206365 5
simulate:wclsnfspbadapa1:WireCellToolkit 52.7813 54.0306 55.7504 53.2564 1.31698 5
[art]:TriggerResults:TriggerResultInserter 3.2033e-05 4.2412e-05 7.3638e-05 3.3062e-05 1.59058e-05 5
end_path:out1:RootOutput 8.865e-06 1.11678e-05 1.7552e-05 9.828e-06 3.21313e-06 5
end_path:out1:RootOutput(write) 0.230273 0.334935 0.40084 0.337528 0.0598847 5
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4990.02 MB
Peak resident set size usage (VmHWM): 3371.37 MB
Details saved in: 'mem.db'
====================================================================================================
{'art_out': 'placeholder_1_401876_33_1747910467_stage1_stage2_stage3_stage4_stage5_stage6.root'}
extract
Running extract
['lar', '-c', 'run_extract_wire.fcl', 'placeholder_1_401876_33_1747910467_stage1_stage2_stage3_stage4_stage5_stage6.root', '-n', '-1', '-e', '401876:33:1']
Stdout:
Begin processing the 1st record. run: 401876 subRun: 33 event: 1 at 22-May-2025 05:28:41 PDT
Begin processing the 2nd record. run: 401876 subRun: 33 event: 2 at 22-May-2025 05:28:49 PDT
Begin processing the 3rd record. run: 401876 subRun: 33 event: 3 at 22-May-2025 05:28:57 PDT
Begin processing the 4th record. run: 401876 subRun: 33 event: 4 at 22-May-2025 05:29:06 PDT
Begin processing the 5th record. run: 401876 subRun: 33 event: 5 at 22-May-2025 05:29:15 PDT
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).
22-May-2025 05:28:41 PDT Initiating request to open input file "placeholder_1_401876_33_1747910467_stage1_stage2_stage3_stage4_stage5_stage6.root"
22-May-2025 05:28:41 PDT Opened input file "placeholder_1_401876_33_1747910467_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
22-May-2025 05:29:22 PDT Closed input file "placeholder_1_401876_33_1747910467_stage1_stage2_stage3_stage4_stage5_stage6.root"
======================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
======================================================================================================================
Full event 1.71239 2.82727 3.98393 2.72511 0.78396 5
----------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000302152 0.000758108 0.00126276 0.000815673 0.00034679 5
end_path:extractwire:ExtractWire 1.71093 2.82621 3.98288 2.72399 0.784001 5
======================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 3206.96 MB
Peak resident set size usage (VmHWM): 2353.98 MB
Details saved in: 'mem.db'
====================================================================================================
{'art_out': 'placeholder_1_401876_33_1747910467_stage1_stage2_stage3_stage4_stage5_stage6_extract.root', 'start_time': 1747916883.1946177, 'end_time': 1747916963.0436392}
extracted_wires_r401876_s00033.h5 