justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 38781.0@dunegpschedd01.fnal.gov

Jobsub ID38781.0@dunegpschedd01.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 07:42:26
SiteBR_CBPF
EntryDUNE_BR_CBPF_ce01
Last heartbeat2025-09-02 08:04:26
From worker nodeHostnamewn56
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 statenone_processed
Started2025-09-02 07:43:23
Input filesmonte-carlo-002176-000001
Outputting started2025-09-02 08:03:12
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/rraut/fnal/02176/1/001/detsim_38781_0_20250902T074333Z.root
https://fndcadoor.fnal.gov:2880/dune/scratch/users/rraut/fnal/02176/1/001/detsim_hist_g4_stage2_38781_0_20250902T074333Z.root
Finished2025-09-02 08:04:26
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

compressed json file: /cvmfs/dune.opensciencegrid.org/products/dune/dunereco/v10_08_00d00/wire-cell-cfg/pdvd-bottom-noise-spectra-v1.json.bz2
[04:49:03.318] 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
[04:49:10.794] 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
[04:49:11.044] 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
[04:49:11.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
[04:49:11.099] 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
[04:49:11.127] 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 04:49:11 -03  Initiating request to open input file "g4_stage2_38781_0_20250902T074333Z.root"
%MSG-i Root_Information:  TriggerResultInserter:TriggerResults@Construction  TClass::Init() 02-Sep-2025 04:49:11 -03 ModuleConstruction
no dictionary for class sim::IDE is available
ROOT severity: 2000
%MSG
02-Sep-2025 04:49:11 -03  Opened input file "g4_stage2_38781_0_20250902T074333Z.root"
Masked Channels:
Begin processing the 1st record. run: 1 subRun: 0 event: 1 at 02-Sep-2025 04:49:12 -03
SimDepoSource got 2394385 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 2394385 depos spanning: [-2992.53, 2937.17]us
[05:01:45.139] 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
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 22.7 sec
[05:02:43.112] I [ timer  ] Timer: wcls::SimChannelSink : 22.68 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 21.66 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 20.94 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Drifter : 20.36 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 18.77 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::DepoBagger : 12.22 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 12.21 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 11.86 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 11.12 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 9.6 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Digitizer : 9.36 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 9.3 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Digitizer : 9.27 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Digitizer : 9.12 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 9.09 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Digitizer : 9.02 sec
[05:02:43.112] I [ timer  ] Timer: wcls::FrameSaver : 8.94 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 8.91 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Digitizer : 8.91 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Digitizer : 8.88 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Digitizer : 8.86 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 8.84 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 8.83 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 8.8 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 8.76 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Digitizer : 8.7 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 8.67 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 8.65 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 8.62 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 8.62 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 8.61 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 8.48 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 8.39 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Retagger : 8.36 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 8.27 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 8.2 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 8.16 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 8.13 sec
[05:02:43.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 8.09 sec
[05:02:43.112] I [ timer  ] Timer: wcls::SimDepoSource : 3.83 sec
[05:02:43.112] I [ timer  ] Timer: Total node execution : 440.79000186920166 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Creating Maker on Plane C:0 S:0 P:0
Created 11 TAs on ROP C:0 S:0 P:0
Creating Maker on Plane C:0 S:0 P:1
Created 10 TAs on ROP C:0 S:0 P:1
Creating Maker on Plane C:0 S:0 P:2
Created 10 TAs on ROP C:0 S:0 P:2
Creating Maker on Plane C:0 S:1 P:0
Created 9 TAs on ROP C:0 S:1 P:0
Creating Maker on Plane C:0 S:1 P:1
Created 10 TAs on ROP C:0 S:1 P:1
Creating Maker on Plane C:0 S:1 P:2
Created 9 TAs on ROP C:0 S:1 P:2
Creating Maker on Plane C:0 S:2 P:0
Created 16 TAs on ROP C:0 S:2 P:0
Creating Maker on Plane C:0 S:2 P:1
Created 16 TAs on ROP C:0 S:2 P:1
Creating Maker on Plane C:0 S:2 P:2
Created 16 TAs on ROP C:0 S:2 P:2
Creating Maker on Plane C:0 S:3 P:0
Created 29 TAs on ROP C:0 S:3 P:0
Creating Maker on Plane C:0 S:3 P:1
Created 29 TAs on ROP C:0 S:3 P:1
Creating Maker on Plane C:0 S:3 P:2
Created 29 TAs on ROP C:0 S:3 P:2
02-Sep-2025 05:02:49 -03  Opened output file with pattern "detsim_38781_0_20250902T074333Z.root"
%MSG-i FastCloning:  PostProcessEvent 02-Sep-2025 05:02:49 -03  run: 1 subRun: 0 event: 1
Fast cloning event data products from input file.
%MSG
02-Sep-2025 05:03:01 -03  Closed output file "detsim_38781_0_20250902T074333Z.root"
02-Sep-2025 05:03:01 -03  Closed input file "g4_stage2_38781_0_20250902T074333Z.root"

==================================================================================================================================
TimeTracker printout (sec)                          Min           Avg           Max         Median          RMS         nEvts   
==================================================================================================================================
Full event                                        823.987       823.987       823.987       823.987          0            1     
----------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                          0.00100637    0.00100637    0.00100637    0.00100637         0            1     
simulate:rns:RandomNumberSaver                  0.000328011   0.000328011   0.000328011   0.000328011        0            1     
simulate:tpcrawdecoder:WireCellToolkit            812.725       812.725       812.725       812.725          0            1     
simulate:tpmakerTPC:TriggerPrimitiveMakerTPC      4.07778       4.07778       4.07778       4.07778          0            1     
simulate:tamakerTPC:TriggerActivityMakerTPC      0.0320631     0.0320631     0.0320631     0.0320631         0            1     
[art]:TriggerResults:TriggerResultInserter      0.000156276   0.000156276   0.000156276   0.000156276        0            1     
end_path:out1:RootOutput                        5.0321e-05    5.0321e-05    5.0321e-05    5.0321e-05         0            1     
end_path:out1:RootOutput(write)                   7.02405       7.02405       7.02405       7.02405          0            1     
==================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 02-Sep-2025 05:03:03 -03  ModuleEndJob

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

%MSG

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

  Peak virtual memory usage (VmPeak)  : 4025.06 MB
  Peak resident set size usage (VmHWM): 2531.31 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 = 790.432191 Real = 837.619790

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 4025.06 VmHWM = 2531.31

Art has completed and will exit with status 0.
----Jobscript Finished----
-rw-r--r-- 1 nobody nobody 118M Sep  2 05:03 detsim_38781_0_20250902T074333Z.root
-rw-r--r-- 1 nobody nobody  519 Sep  2 05:03 detsim_hist_g4_stage2_38781_0_20250902T074333Z.root
-rw-r--r-- 1 nobody nobody  519 Sep  2 04:47 g4_hist_g4_stage1_38781_0_20250902T074333Z.root
lar exit code: 0
Job completed successfully with 1 event generated
justIN time: 2025-09-19 05:07:38 UTC       justIN version: 01.05.00