justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 31991.0@dunegpschedd02.fnal.gov

Jobsub ID31991.0@dunegpschedd02.fnal.gov
Workflow ID2176
Stage ID1
User namerraut@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes2097152000 (2000 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2025-09-02 06:20:22
SiteBR_CBPF
EntryDUNE_BR_CBPF_ce01
Last heartbeat2025-09-02 06:45:46
From worker nodeHostnamewn50
cpuinfoIntel(R) Xeon(R) CPU E5-2640 v4 @ 2.40GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes2097152000 (2000 MiB)
Wall seconds limit257400 (71 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-09-02 06:21:47
Input files
JobscriptExit code0
Real time22m (1371s)
CPU time20m (1228s = 89%)
Max RSS bytes4143075328 (3951 MiB)
Outputting started2025-09-02 06:44:39
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/rraut/fnal/02176/1/001/detsim_hist_g4_stage2_31991_0_20250902T062200Z.root
https://fndcadoor.fnal.gov:2880/dune/scratch/users/rraut/fnal/02176/1/001/detsim_31991_0_20250902T062200Z.root
Finished2025-09-02 06:45:46
Saved logsjustin-logs:31991.0-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

ressed json file: /cvmfs/dune.opensciencegrid.org/products/dune/dunereco/v10_08_00d00/wire-cell-cfg/pdvd-bottom-noise-spectra-v1.json.bz2
[03:27:49.067] I [  wct   ] loading compressed json file: /cvmfs/dune.opensciencegrid.org/products/dune/dunereco/v10_08_00d00/wire-cell-cfg/protodunevd_FR_3view_speed1d55.json.bz2
[03:27:56.833] I [  wct   ] loading compressed json file: /cvmfs/dune.opensciencegrid.org/products/dune/dunereco/v10_08_00d00/wire-cell-cfg/dunevd-coldbox-elecresp-top-psnorm_400.json.bz2
[03:27:57.072] I [  wct   ] loading compressed json file: /cvmfs/dune.opensciencegrid.org/products/dune/dunereco/v10_08_00d00/wire-cell-cfg/pdvd-top-noise-spectra-v2.json.bz2
[03:27:57.109] I [  wct   ] loading compressed json file: /cvmfs/dune.opensciencegrid.org/products/dune/dunereco/v10_08_00d00/wire-cell-cfg/pdvd-top-noise-spectra-v2.json.bz2
[03:27:57.149] I [  wct   ] loading compressed json file: /cvmfs/dune.opensciencegrid.org/products/dune/dunereco/v10_08_00d00/wire-cell-cfg/pdvd-top-noise-spectra-v2.json.bz2
[03:27:57.189] I [  wct   ] loading compressed json file: /cvmfs/dune.opensciencegrid.org/products/dune/dunereco/v10_08_00d00/wire-cell-cfg/pdvd-top-noise-spectra-v2.json.bz2
Inputer: "wclsSimDepoSource:electron"
Outputer: "wclsSimChannelSink:postdrift"
Outputer: "wclsFrameSaver:simdigits"
wclsFrameSaver: promising to produce raw::RawDigits named "daq"
02-Sep-2025 03:27:57 -03  Initiating request to open input file "g4_stage2_31991_0_20250902T062200Z.root"
%MSG-i Root_Information:  TriggerResultInserter:TriggerResults@Construction  TClass::Init() 02-Sep-2025 03:27:57 -03 ModuleConstruction
no dictionary for class sim::IDE is available
ROOT severity: 2000
%MSG
02-Sep-2025 03:27:57 -03  Opened input file "g4_stage2_31991_0_20250902T062200Z.root"
Masked Channels:
Begin processing the 1st record. run: 1 subRun: 0 event: 1 at 02-Sep-2025 03:27:58 -03
SimDepoSource got 2811015 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 2811015 depos spanning: [-2997.62, 2895.93]us
[03:42:08.113] W [  gen   ] <IncoherentAddNoise:addnoise-empericalnoise-anode7> model EmpiricalNoiseModel:empericalnoise-anode7 produced 6174 samples instead of expected 6000, future warnings muted 
Retagger: tagging trace set: daq with 12288 traces, 0 summary
[03:44:18.129] I [ timer  ] Timer: wcls::SimChannelSink : 40.39 sec
[03:44:18.129] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 35 sec
[03:44:18.129] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 33.26 sec
[03:44:18.129] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 30.23 sec
[03:44:18.129] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 29.68 sec
[03:44:18.129] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 27.53 sec
[03:44:18.129] I [ timer  ] Timer: WireCell::Gen::Drifter : 23.9 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 21.63 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 21.27 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 21.26 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::DepoBagger : 14.11 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Digitizer : 10.24 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Reframer : 10.15 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Digitizer : 10.15 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Digitizer : 10.13 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 9.94 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Digitizer : 9.9 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Digitizer : 9.88 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 9.87 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 9.65 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Digitizer : 9.55 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Reframer : 9.54 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 9.47 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Digitizer : 9.37 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Reframer : 9.37 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 9.32 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 9.3 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Digitizer : 9.29 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Retagger : 9.26 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 9.25 sec
[03:44:18.130] I [ timer  ] Timer: wcls::FrameSaver : 9.25 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 9.24 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Reframer : 9.24 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 9.21 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Reframer : 9.19 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 9.14 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 9.07 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Reframer : 8.98 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Reframer : 8.89 sec
[03:44:18.130] I [ timer  ] Timer: WireCell::Gen::Reframer : 8.78 sec
[03:44:18.130] I [ timer  ] Timer: wcls::SimDepoSource : 4.64 sec
[03:44:18.130] I [ timer  ] Timer: Total node execution : 577.5199942588806 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Creating Maker on Plane C:0 S:0 P:0
Created 29 TAs on ROP C:0 S:0 P:0
Creating Maker on Plane C:0 S:0 P:1
Created 30 TAs on ROP C:0 S:0 P:1
Creating Maker on Plane C:0 S:0 P:2
Created 29 TAs on ROP C:0 S:0 P:2
Creating Maker on Plane C:0 S:1 P:0
Created 32 TAs on ROP C:0 S:1 P:0
Creating Maker on Plane C:0 S:1 P:1
Created 31 TAs on ROP C:0 S:1 P:1
Creating Maker on Plane C:0 S:1 P:2
Created 31 TAs on ROP C:0 S:1 P:2
Creating Maker on Plane C:0 S:2 P:0
Created 30 TAs on ROP C:0 S:2 P:0
Creating Maker on Plane C:0 S:2 P:1
Created 30 TAs on ROP C:0 S:2 P:1
Creating Maker on Plane C:0 S:2 P:2
Created 28 TAs on ROP C:0 S:2 P:2
Creating Maker on Plane C:0 S:3 P:0
Created 32 TAs on ROP C:0 S:3 P:0
Creating Maker on Plane C:0 S:3 P:1
Created 32 TAs on ROP C:0 S:3 P:1
Creating Maker on Plane C:0 S:3 P:2
Created 32 TAs on ROP C:0 S:3 P:2
02-Sep-2025 03:44:23 -03  Opened output file with pattern "detsim_31991_0_20250902T062200Z.root"
%MSG-i FastCloning:  PostProcessEvent 02-Sep-2025 03:44:24 -03  run: 1 subRun: 0 event: 1
Fast cloning event data products from input file.
%MSG
02-Sep-2025 03:44:35 -03  Closed output file "detsim_31991_0_20250902T062200Z.root"
02-Sep-2025 03:44:35 -03  Closed input file "g4_stage2_31991_0_20250902T062200Z.root"

==================================================================================================================================
TimeTracker printout (sec)                          Min           Avg           Max         Median          RMS         nEvts   
==================================================================================================================================
Full event                                        993.902       993.902       993.902       993.902          0            1     
----------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                          0.00109762    0.00109762    0.00109762    0.00109762         0            1     
simulate:rns:RandomNumberSaver                  0.000331408   0.000331408   0.000331408   0.000331408        0            1     
simulate:tpcrawdecoder:WireCellToolkit            981.605       981.605       981.605       981.605          0            1     
simulate:tpmakerTPC:TriggerPrimitiveMakerTPC      3.47736       3.47736       3.47736       3.47736          0            1     
simulate:tamakerTPC:TriggerActivityMakerTPC      0.122554      0.122554      0.122554      0.122554          0            1     
[art]:TriggerResults:TriggerResultInserter      0.000176552   0.000176552   0.000176552   0.000176552        0            1     
end_path:out1:RootOutput                        5.7386e-05    5.7386e-05    5.7386e-05    5.7386e-05         0            1     
end_path:out1:RootOutput(write)                   8.34512       8.34512       8.34512       8.34512          0            1     
==================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 02-Sep-2025 03:44:35 -03  ModuleEndJob

Summary of seeds computed by the NuRandomService
Random policy: 'random'
  master seed: 455671854
  seed within: [ 1 ; 900000000 ]

%MSG

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

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

TrigReport ---------- Event summary -------------
TrigReport Events total = 1 passed = 1 failed = 0

TrigReport ---------- Modules in End-path ----------
TrigReport        Run    Success      Error Name
TrigReport          1          1          0 out1

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 963.200746 Real = 999.621284

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 4303.9 VmHWM = 2824.39

Art has completed and will exit with status 0.
----Jobscript Finished----
-rw-r--r-- 1 nobody nobody 144M Sep  2 03:44 detsim_31991_0_20250902T062200Z.root
-rw-r--r-- 1 nobody nobody  519 Sep  2 03:44 detsim_hist_g4_stage2_31991_0_20250902T062200Z.root
-rw-r--r-- 1 nobody nobody  519 Sep  2 03:26 g4_hist_g4_stage1_31991_0_20250902T062200Z.root
lar exit code: 0
Job completed successfully with 1 event generated
justIN time: 2025-09-19 08:33:30 UTC       justIN version: 01.05.00