21 July 2025: This instance at RAL is read-only. Please do not try submitting new workflows for now.
Jobsub ID 416123.0@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 416123.0@justin-prod-sched01.dune.hep.ac.uk | |
| Workflow ID | 7666 | |
| Stage ID | 1 | |
| User name | calcuttj@fnal.gov | |
| HTCondor Group | group_dune | |
| Requested | Processors | 1 |
| GPU | No | |
| RSS bytes | 2097152000 (2000 MiB) | |
| Wall seconds limit | 80000 (22 hours) | |
| Submitted time | 2025-06-17 21:31:13 | |
| Site | UK_RAL-Tier1 | |
| Entry | LIGO_UK_RAL_arc_ce05 | |
| Last heartbeat | 2025-06-17 23:46:12 | |
| From worker node | Hostname | dune001-6317891.0-lcg2384.gridpp.rl.ac.uk |
| cpuinfo | Intel(R) Xeon(R) Gold 6130 CPU @ 2.10GHz | |
| OS release | Scientific Linux release 7.9 (Nitrogen) | |
| Processors | 1 | |
| RSS bytes | 2097152000 (2000 MiB) | |
| Wall seconds limit | 216000 (60 hours) | |
| GPU | ||
| Inner Apptainer? | True | |
| Job state | finished | |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk | |
| Started | 2025-06-17 21:32:29 | |
| Input files | monte-carlo-007666-000089 | |
| Jobscript | Exit code | 0 |
| Real time | 2h (8000s) | |
| CPU time | 2h (7789s = 97%) | |
| Max RSS bytes | 17872216064 (17044 MiB) | |
| Outputting started | 2025-06-17 23:45:49 | |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/calcuttj/extracted_raw/07666/1/001/extracted_raw_1_0_416123_20250617T213231Z_416123_0_1.h5 | |
| Finished | 2025-06-17 23:46:12 | |
| Saved logs | justin-logs:416123.0-justin-prod-sched01.dune.hep.ac.uk.logs.tgz | |
| List job events Wrapper job log | ||
Jobscript log (last 10,000 characters)
=============================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
===================================================================================================================================
Full event 453.855 695.783 877.289 732.93 117.357 10
-----------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000699235 0.00367409 0.00654498 0.00357027 0.00177989 10
simulate:tpcrawdecoderperfect:WireCellToolkit 449.865 683.11 852.721 723.778 113.05 10
[art]:TriggerResults:TriggerResultInserter 5.389e-05 0.000190982 0.00100083 7.7913e-05 0.000278243 10
end_path:out1:RootOutput 1.4507e-05 0.000199457 0.00181223 1.8107e-05 0.000537647 10
end_path:out1:RootOutput(write) 2.91553 3.34013 4.57484 3.21519 0.467897 10
===================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 23640.3 MB
Peak resident set size usage (VmHWM): 17872.2 MB
Details saved in: 'mem.db'
====================================================================================================
{'art_out': 'placeholder_1_416123_0_1750195960_stage1_stage2_stage3.root'}
stage4
Running stage4
['lar', '-c', 'run_nf_perfect_apa1.fcl', 'placeholder_1_416123_0_1750195960_stage1_stage2_stage3.root', '-n', '-1', '-e', '416123:0:1', '-o', 'placeholder_1_416123_0_1750195960_stage1_stage2_stage3_stage4.root']
ld_preload /usr/libexec/coreutils/libstdbuf.so
Stdout:
Begin processing the 1st record. run: 416123 subRun: 0 event: 1 at 17-Jun-2025 23:41:14 UTC
Begin processing the 2nd record. run: 416123 subRun: 0 event: 2 at 17-Jun-2025 23:41:50 UTC
Begin processing the 3rd record. run: 416123 subRun: 0 event: 3 at 17-Jun-2025 23:42:20 UTC
Begin processing the 4th record. run: 416123 subRun: 0 event: 4 at 17-Jun-2025 23:42:47 UTC
Begin processing the 5th record. run: 416123 subRun: 0 event: 5 at 17-Jun-2025 23:43:08 UTC
Begin processing the 6th record. run: 416123 subRun: 0 event: 6 at 17-Jun-2025 23:43:28 UTC
Begin processing the 7th record. run: 416123 subRun: 0 event: 7 at 17-Jun-2025 23:43:55 UTC
Begin processing the 8th record. run: 416123 subRun: 0 event: 8 at 17-Jun-2025 23:44:25 UTC
Begin processing the 9th record. run: 416123 subRun: 0 event: 9 at 17-Jun-2025 23:44:49 UTC
Begin processing the 10th record. run: 416123 subRun: 0 event: 10 at 17-Jun-2025 23:45:14 UTC
Art has completed and will exit with status 0.
Stderr:
The following paths have not been enabled for execution and will be ignored:
analyze
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).
Inputer: "wclsRawFrameSource"
Outputer: "wclsFrameSaver:nfsaver"
wclsFrameSaver: promising to produce raw::RawDigits named "raw"
wclsFrameSaver: promising to produce channel masks named "bad"
17-Jun-2025 23:41:13 UTC Initiating request to open input file "placeholder_1_416123_0_1750195960_stage1_stage2_stage3.root"
17-Jun-2025 23:41:14 UTC Opened input file "placeholder_1_416123_0_1750195960_stage1_stage2_stage3.root"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: raw with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "raw"
wclsFrameSaver: found empty channel masks for "bad"
17-Jun-2025 23:41:38 UTC Opened output file with pattern "placeholder_1_416123_0_1750195960_stage1_stage2_stage3_stage4.root"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: raw with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "raw"
wclsFrameSaver: found empty channel masks for "bad"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: raw with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "raw"
wclsFrameSaver: found empty channel masks for "bad"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: raw with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "raw"
wclsFrameSaver: found empty channel masks for "bad"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: raw with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "raw"
wclsFrameSaver: found empty channel masks for "bad"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: raw with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "raw"
wclsFrameSaver: found empty channel masks for "bad"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: raw with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "raw"
wclsFrameSaver: found empty channel masks for "bad"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: raw with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "raw"
wclsFrameSaver: found empty channel masks for "bad"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: raw with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "raw"
wclsFrameSaver: found empty channel masks for "bad"
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: raw with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "raw"
wclsFrameSaver: found empty channel masks for "bad"
17-Jun-2025 23:45:35 UTC Closed output file "placeholder_1_416123_0_1750195960_stage1_stage2_stage3_stage4.root"
17-Jun-2025 23:45:35 UTC Closed input file "placeholder_1_416123_0_1750195960_stage1_stage2_stage3.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 15.4041 19.462 23.2171 19.9502 2.79261 10
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000268143 0.000508533 0.00111353 0.000468679 0.000230685 10
simulate:wclsnfperfect:WireCellToolkit 12.7622 16.3243 20.7325 16.4847 2.59715 10
[art]:TriggerResults:TriggerResultInserter 1.4959e-05 2.66149e-05 8.0478e-05 2.0884e-05 1.84214e-05 10
end_path:out1:RootOutput 2.816e-06 5.6895e-06 2.262e-05 3.355e-06 5.7588e-06 10
end_path:out1:RootOutput(write) 2.40481 3.13681 4.40196 3.21518 0.623432 10
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4828.61 MB
Peak resident set size usage (VmHWM): 3099.25 MB
Details saved in: 'mem.db'
====================================================================================================
{'art_out': 'placeholder_1_416123_0_1750195960_stage1_stage2_stage3_stage4.root', 'start_time': 1750203621.5793302, 'end_time': 1750203937.0673885}
TClass::Init:0: RuntimeWarning: no dictionary for class sim::IDE is available
Successfully opened file placeholder_1_416123_0_1750195960_stage1_stage2_stage3_stage4.root
<cppyy.gbl.art.InputTag object at 0x1f6a1820>
1 0 416123
extracted_raw_1_0_416123.h5