Jobsub ID 401878.100@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 401878.100@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:43:21 |
| Site | CA_SFU |
| Entry | DUNE_CA_SFU_lcg-ce3 |
| Last heartbeat | 2025-05-22 12:36:47 |
| 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:51:02 |
| Input files | monte-carlo-007106-008112
|
| Jobscript | Exit code | 0 |
| Real time | 1h (6291s) |
| CPU time | 1h (6232s = 99%) |
| Max RSS bytes | 11475103744 (10943 MiB) |
| Outputting started | 2025-05-22 12:35:54 |
| Output files | usertests:extracted_wires_r401878_s00100_20250522T105104Z_401878_100_1.h5
|
| Finished | 2025-05-22 12:36:47 |
| Saved logs | justin-logs:401878.100-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
| List job events Wrapper job log |
Jobscript log (last 10,000 characters)
ionsMap_
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:29:41 PDT Initiating request to open input file "placeholder_1_401878_100_1747911068_stage1_stage2_stage3_stage4_stage5.root"
22-May-2025 05:29:42 PDT Opened input file "placeholder_1_401878_100_1747911068_stage1_stage2_stage3_stage4_stage5.root"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 85477 traces, 85477 summary
Retagger: tagging trace set: gauss with 74647 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 74647 traces tagged "gauss"
FrameSaver: q=1.99962e+06 n=1195037 tag=gauss
wclsFrameSaver: saving 85477 traces tagged "wiener"
FrameSaver: q=2.19401e+06 n=1112775 tag=wiener
22-May-2025 05:30:39 PDT Opened output file with pattern "placeholder_1_401878_100_1747911068_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 87833 traces, 87833 summary
Retagger: tagging trace set: gauss with 69727 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 69727 traces tagged "gauss"
FrameSaver: q=1.93305e+06 n=954359 tag=gauss
wclsFrameSaver: saving 87833 traces tagged "wiener"
FrameSaver: q=2.22731e+06 n=898428 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 91847 traces, 91847 summary
Retagger: tagging trace set: gauss with 77447 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 77447 traces tagged "gauss"
FrameSaver: q=2.08149e+06 n=1179535 tag=gauss
wclsFrameSaver: saving 91847 traces tagged "wiener"
FrameSaver: q=2.31809e+06 n=1098241 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 59468 traces, 59468 summary
Retagger: tagging trace set: gauss with 52580 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 52580 traces tagged "gauss"
FrameSaver: q=993689 n=664317 tag=gauss
wclsFrameSaver: saving 59468 traces tagged "wiener"
FrameSaver: q=1.13383e+06 n=627899 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 110239 traces, 110239 summary
Retagger: tagging trace set: gauss with 87383 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 87383 traces tagged "gauss"
FrameSaver: q=2.67046e+06 n=1333127 tag=gauss
wclsFrameSaver: saving 110239 traces tagged "wiener"
FrameSaver: q=2.94982e+06 n=1201201 tag=wiener
22-May-2025 05:34:36 PDT Closed output file "placeholder_1_401878_100_1747911068_stage1_stage2_stage3_stage4_stage5_stage6.root"
22-May-2025 05:34:36 PDT Closed input file "placeholder_1_401878_100_1747911068_stage1_stage2_stage3_stage4_stage5.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 52.2209 53.2811 55.6052 52.9689 1.22061 5
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000469549 0.000769036 0.0010393 0.00076153 0.000219278 5
simulate:wclsnfspbadapa1:WireCellToolkit 51.8451 52.9291 55.3734 52.577 1.27034 5
[art]:TriggerResults:TriggerResultInserter 2.2755e-05 3.87422e-05 7.5164e-05 3.0973e-05 1.85994e-05 5
end_path:out1:RootOutput 3.887e-06 1.1129e-05 2.0052e-05 1.1052e-05 5.20267e-06 5
end_path:out1:RootOutput(write) 0.228846 0.348936 0.429947 0.372857 0.0689662 5
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4912.93 MB
Peak resident set size usage (VmHWM): 3290.96 MB
Details saved in: 'mem.db'
====================================================================================================
{'art_out': 'placeholder_1_401878_100_1747911068_stage1_stage2_stage3_stage4_stage5_stage6.root'}
extract
Running extract
['lar', '-c', 'run_extract_wire.fcl', 'placeholder_1_401878_100_1747911068_stage1_stage2_stage3_stage4_stage5_stage6.root', '-n', '-1', '-e', '401878:100:1']
Stdout:
Begin processing the 1st record. run: 401878 subRun: 100 event: 1 at 22-May-2025 05:35:13 PDT
Begin processing the 2nd record. run: 401878 subRun: 100 event: 2 at 22-May-2025 05:35:21 PDT
Begin processing the 3rd record. run: 401878 subRun: 100 event: 3 at 22-May-2025 05:35:28 PDT
Begin processing the 4th record. run: 401878 subRun: 100 event: 4 at 22-May-2025 05:35:36 PDT
Begin processing the 5th record. run: 401878 subRun: 100 event: 5 at 22-May-2025 05:35:43 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:35:13 PDT Initiating request to open input file "placeholder_1_401878_100_1747911068_stage1_stage2_stage3_stage4_stage5_stage6.root"
22-May-2025 05:35:13 PDT Opened input file "placeholder_1_401878_100_1747911068_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:35:53 PDT Closed input file "placeholder_1_401878_100_1747911068_stage1_stage2_stage3_stage4_stage5_stage6.root"
======================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
======================================================================================================================
Full event 2.3293 2.86433 3.67434 2.78572 0.459321 5
----------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000332368 0.000780712 0.00130205 0.000789998 0.000358298 5
end_path:extractwire:ExtractWire 2.32875 2.86324 3.67282 2.78458 0.459069 5
======================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 3116.9 MB
Peak resident set size usage (VmHWM): 2263.48 MB
Details saved in: 'mem.db'
====================================================================================================
{'art_out': 'placeholder_1_401878_100_1747911068_stage1_stage2_stage3_stage4_stage5_stage6_extract.root', 'start_time': 1747917277.4304528, 'end_time': 1747917353.6205046}
extracted_wires_r401878_s00100.h5 