justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 240221.84@dunegpschedd01.fnal.gov

Jobsub ID240221.84@dunegpschedd01.fnal.gov
Workflow ID9375
Stage ID1
User nameykermaid@fnal.gov
HTCondor Groupgroup_dune.prod_mcsim
RequestedProcessors1
GPUNo
RSS bytes4193255424 (3999 MiB)
Wall seconds limit18000 (5 hours)
Submitted time2025-10-29 12:44:27
SiteNL_NIKHEF
EntryVIRGO_NL_NIKHEF_klomp
Last heartbeat2025-10-29 12:55:15
From worker nodeHostnamewn-sate-048.farm.nikhef.nl
cpuinfoAMD EPYC 7551P 32-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit129600 (36 hours)
GPU
Inner Apptainer?True
Job stateaborted
Started2025-10-29 12:45:48
Input filesvd-protodune:np02vd_raw_run040267_0075_df-s04-d1_dw_0_20251025T204128.hdf5
Outputting started 
Output files
Finished2025-10-29 12:55:15
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ](WireCell::IFrame:0)
[13:46:24.133] D [ pgraph ] connect <Node  type:WireCell::Aux::Resampler cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ]:(WireCell::IFrame:0) -> <Node  type:WireCell::SigProc::OmnibusSigProc cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ](WireCell::IFrame:0)
[13:46:24.133] D [ pgraph ] connect <Node  type:WireCell::SigProc::ChannelSelector cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ]:(WireCell::IFrame:0) -> <Node  type:WireCell::Aux::Resampler cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ](WireCell::IFrame:0)
[13:46:24.133] D [ pgraph ] connect <Node  type:WireCell::Aux::Resampler cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ]:(WireCell::IFrame:0) -> <Node  type:WireCell::SigProc::OmnibusSigProc cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ](WireCell::IFrame:0)
[13:46:24.133] D [ pgraph ] connect <Node  type:WireCell::SigProc::ChannelSelector cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ]:(WireCell::IFrame:0) -> <Node  type:WireCell::Aux::Resampler cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ](WireCell::IFrame:0)
[13:46:24.133] D [ pgraph ] connect <Node  type:WireCell::Aux::Resampler cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ]:(WireCell::IFrame:0) -> <Node  type:WireCell::SigProc::OmnibusSigProc cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ](WireCell::IFrame:0)
[13:46:24.133] D [ pgraph ] connect <Node  type:WireCell::SigProc::ChannelSelector cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ]:(WireCell::IFrame:0) -> <Node  type:WireCell::SigProc::OmnibusSigProc cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ](WireCell::IFrame:0)
[13:46:24.133] D [ pgraph ] connect <Node  type:WireCell::SigProc::ChannelSelector cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ]:(WireCell::IFrame:0) -> <Node  type:WireCell::SigProc::OmnibusSigProc cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ](WireCell::IFrame:0)
[13:46:24.133] D [ pgraph ] connect <Node  type:WireCell::SigProc::ChannelSelector cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ]:(WireCell::IFrame:0) -> <Node  type:WireCell::SigProc::OmnibusSigProc cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ](WireCell::IFrame:0)
[13:46:24.133] D [ pgraph ] connect <Node  type:WireCell::SigProc::ChannelSelector cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ]:(WireCell::IFrame:0) -> <Node  type:WireCell::SigProc::OmnibusSigProc cat:3 sig:WireCell::IFrameFilter inputs:[ WireCell::IFrame ] outputs:[ WireCell::IFrame ](WireCell::IFrame:0)
Inputer: "wclsRawFrameSource"
Outputer: "wclsFrameSaver:spsaver"
wclsFrameSaver: promising to produce recob::Wires named "gauss"
wclsFrameSaver: promising to produce recob::Wires named "wiener"
db: runtime1761424887
Scale HitLimit based on readout window size 10000
HitLimit = 33333
RawFrameSource: got 12288 raw::RawDigit objects
	input nticks=8642 keeping as is
[13:48:51.054] D [  main  ] executing 1 apps, thread limit 0:
[13:48:51.054] D [  main  ] executing 1 apps, thread limit 0:
[13:48:51.054] D [  main  ] executing app: "Pgrapher"
[13:48:51.054] D [ pgraph ] <Pgrapher:> executing graph 
[13:48:51.054] D [ pgraph ] executing with 26 nodes
[13:48:51.056] D [  glue  ] <FrameFanout:nfsp> call=0: input: frame: ident=13949 time=0 tick=512 with 12288 traces.  frame tags:[ "orig" ] 0 tagged trace sets:[ ] cmm:[ ] output 0: frame: ident=13949 time=0 tick=512 with 12288 traces.  frame tags:[ "orig0" ] 0 tagged trace sets:[ ] cmm:[ ] output 1: frame: ident=13949 time=0 tick=512 with 12288 traces.  frame tags:[ "orig1" ] 0 tagged trace sets:[ ] cmm:[ ] output 2: frame: ident=13949 time=0 tick=512 with 12288 traces.  frame tags:[ "orig2" ] 0 tagged trace sets:[ ] cmm:[ ] output 3: frame: ident=13949 time=0 tick=512 with 12288 traces.  frame tags:[ "orig3" ] 0 tagged trace sets:[ ] cmm:[ ] output 4: frame: ident=13949 time=0 tick=512 with 12288 traces.  frame tags:[ "orig4" ] 0 tagged trace sets:[ ] cmm:[ ] output 5: frame: ident=13949 time=0 tick=512 with 12288 traces.  frame tags:[ "orig5" ] 0 tagged trace sets:[ ] cmm:[ ] output 6: frame: ident=13949 time=0 tick=512 with 12288 traces.  frame tags:[ "orig6" ] 0 tagged trace sets:[ ] cmm:[ ] output 7: frame: ident=13949 time=0 tick=512 with 12288 traces.  frame tags:[ "orig7" ] 0 tagged trace sets:[ ] cmm:[ ]  
[13:48:51.057] W [  glue  ] <ChannelSelector:chsel7> Untagged summary not supported, summary will be dropped. 
[13:48:51.057] D [  glue  ] <ChannelSelector:chsel7> input frame: ident=13949 time=0 tick=512 with 12288 traces.  frame tags:[ "orig7" ] 0 tagged trace sets:[ ] cmm:[ ] output: frame: ident=13949 time=0 tick=512 with 1536 traces.  frame tags:[ "orig7" ] 0 tagged trace sets:[ ] cmm:[ ] 
[13:48:51.057] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 input frame: frame: ident=13949 time=0 tick=512 with 1536 traces.  frame tags:[ "orig7" ] 0 tagged trace sets:[ ] cmm:[ ] 
[13:48:51.058] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 init nticks=8642 tbinmin=0 tbinmax=8642 
[13:48:51.117] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 load plane index: 0, ntraces=1536, input bad regions: 0 
[13:48:53.775] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 load plane index: 1, ntraces=1536, input bad regions: 0 
[13:48:56.485] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 load plane index: 2, ntraces=1536, input bad regions: 0 
[13:49:51.362] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 save plane index: 0, Qtot=54267974378 Qloss=-33316713206, 6521 indices spanning [18529,25049] "wiener" 
[13:49:51.691] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 save plane index: 0, Qtot=52339816899 Qloss=-33473568283, 6038 indices spanning [25050,31087] "gauss" 
[13:49:52.937] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 save plane index: 1, Qtot=30052481178 Qloss=-7769339757, 11231 indices spanning [31088,42318] "wiener" 
[13:49:53.251] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 save plane index: 1, Qtot=25451737593 Qloss=-8002636874, 10719 indices spanning [42319,53037] "gauss" 
[13:49:53.783] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 save plane index: 2, Qtot=3586063698 Qloss=-2371347032, 12876 indices spanning [53038,65913] "wiener" 
[13:49:54.330] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 save plane index: 2, Qtot=3037190310 Qloss=-1827440342, 15129 indices spanning [65914,81042] "gauss" 
[13:49:54.331] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 produce 81043 traces: 30628 wiener7, 0 decon_charge7, 31886 gauss7, frame tag: sigproc 
[13:49:54.331] D [sigproc ] <OmnibusSigProc:anode7sigproc7> call=0 output frame: frame: ident=13949 time=0 tick=512 with 81043 traces.  frame tags:[ "sigproc" ] 4 tagged trace sets:[ "gauss7":31886 [0] "mp2_roi7":13180 [0] "mp3_roi7":5349 [0] "wiener7":30628 [30628] ] cmm:[ ] 
[13:49:59.443] W [  glue  ] <ChannelSelector:chsel6> Untagged summary not supported, summary will be dropped. 
[13:49:59.444] D [  glue  ] <ChannelSelector:chsel6> input frame: ident=13949 time=0 tick=512 with 12288 traces.  frame tags:[ "orig6" ] 0 tagged trace sets:[ ] cmm:[ ] output: frame: ident=13949 time=0 tick=512 with 1536 traces.  frame tags:[ "orig6" ] 0 tagged trace sets:[ ] cmm:[ ] 
[13:49:59.444] D [sigproc ] <OmnibusSigProc:anode6sigproc6> call=0 input frame: frame: ident=13949 time=0 tick=512 with 1536 traces.  frame tags:[ "orig6" ] 0 tagged trace sets:[ ] cmm:[ ] 
[13:49:59.444] D [sigproc ] <OmnibusSigProc:anode6sigproc6> call=0 init nticks=8642 tbinmin=0 tbinmax=8642 
[13:49:59.481] D [sigproc ] <OmnibusSigProc:anode6sigproc6> call=0 load plane index: 0, ntraces=1536, input bad regions: 0 
[13:50:02.400] D [sigproc ] <OmnibusSigProc:anode6sigproc6> call=0 load plane index: 1, ntraces=1536, input bad regions: 0 
[13:50:05.545] D [sigproc ] <OmnibusSigProc:anode6sigproc6> call=0 load plane index: 2, ntraces=1536, input bad regions: 0 
29-Oct-2025 13:51:36 CET  Opened output file with pattern "%ifb_reco_stage1_%tc_keepup.root"
Malformed TimeTracker database.  The TimeEvent table is empty, but
the TimeModule table is not.  This can happen if an exception has
been thrown from a module while processing the first event.  Any
saved database file is suspect and should not be used.

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

  Peak virtual memory usage (VmPeak)  : 8589.81 MB
  Peak resident set size usage (VmHWM): 6596.91 MB
  Details saved in: 'mem.db'
====================================================================================================
%MSG-s ArtException:  PostEndJob 29-Oct-2025 13:51:38 CET ModuleEndJob
---- EventProcessorFailure BEGIN
  EventProcessor: an exception occurred during current event processing
  ---- ScheduleExecutionFailure BEGIN
    Path: ProcessingStopped.
    ---- BadAlloc BEGIN
      A bad_alloc exception was thrown while processing module WireCellToolkit/wclsdatavd run: 40267 subRun: 1 event: 13949
      The job has probably exhausted the virtual memory available to the process.
    ---- BadAlloc END
    Exception going through path produce
  ---- ScheduleExecutionFailure END
---- EventProcessorFailure END
%MSG
Art has completed and will exit with status 1.
Error in reco1
justIN time: 2025-11-05 07:32:14 UTC       justIN version: 01.05.01