Jobsub ID 17258.1@dunegpschedd01.fnal.gov

Jobsub ID	17258.1@dunegpschedd01.fnal.gov
Workflow ID	34
Stage ID	1
User name	timm@fnal.gov
HTCondor Group	group_dune.prod.mcsim
Requested	Processors	1
	GPU	No
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2025-07-22 19:53:48
Site	UK_Sheffield
Entry	DUNE_UK_Sheffield_lcgce2
Last heartbeat	2025-07-22 21:05:59
From worker node	Hostname	wn015.hep
	cpuinfo	Intel(R) Core(TM) i7-5960X CPU @ 3.00GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	257400 (71 hours)
	GPU
	Inner Apptainer?	True
Job state	finished
Started	2025-07-22 19:55:59
Input files	justin-tutorial:tut_np02bde_307160012_np02_bde_coldbox_run012352_0054_20211216T000430.hdf5
Jobscript	Exit code	0
	Real time	58m (3503s)
	CPU time	30m (1838s = 52%)
	Max RSS bytes	1658560512 (1581 MiB)
Outputting started	2025-07-22 20:55:23
Output files	testpro:tut_np02bde_307160012_np02_bde_coldbox_run012352_0054_20211216T000430_reco_data_2025-07-22T_195811Z.root
Finished	2025-07-22 21:05:59
Saved logs	justin-logs:17258.1-dunegpschedd01.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

samples within desired window for channel 2879
wclsFrameSaver: no samples within desired window for channel 2879
wclsFrameSaver: no samples within desired window for channel 2880
wclsFrameSaver: no samples within desired window for channel 2880
wclsFrameSaver: no samples within desired window for channel 2880
wclsFrameSaver: no samples within desired window for channel 2880
wclsFrameSaver: no samples within desired window for channel 2880
wclsFrameSaver: no samples within desired window for channel 2880
wclsFrameSaver: no samples within desired window for channel 2881
wclsFrameSaver: no samples within desired window for channel 2881
wclsFrameSaver: no samples within desired window for channel 2881
wclsFrameSaver: no samples within desired window for channel 2881
wclsFrameSaver: no samples within desired window for channel 2882
wclsFrameSaver: no samples within desired window for channel 2882
wclsFrameSaver: no samples within desired window for channel 2883
wclsFrameSaver: no samples within desired window for channel 2883
wclsFrameSaver: no samples within desired window for channel 2883
wclsFrameSaver: no samples within desired window for channel 2883
wclsFrameSaver: no samples within desired window for channel 2883
wclsFrameSaver: no samples within desired window for channel 2883
wclsFrameSaver: no samples within desired window for channel 2884
wclsFrameSaver: no samples within desired window for channel 2884
wclsFrameSaver: no samples within desired window for channel 2884
wclsFrameSaver: no samples within desired window for channel 2884
wclsFrameSaver: no samples within desired window for channel 2884
wclsFrameSaver: no samples within desired window for channel 2884
wclsFrameSaver: no samples within desired window for channel 2885
wclsFrameSaver: no samples within desired window for channel 2885
wclsFrameSaver: no samples within desired window for channel 2886
wclsFrameSaver: no samples within desired window for channel 2886
wclsFrameSaver: no samples within desired window for channel 2967
wclsFrameSaver: no samples within desired window for channel 2967
wclsFrameSaver: no samples within desired window for channel 2986
wclsFrameSaver: no samples within desired window for channel 2986
wclsFrameSaver: no samples within desired window for channel 3047
wclsFrameSaver: no samples within desired window for channel 3047
wclsFrameSaver: no samples within desired window for channel 3050
wclsFrameSaver: no samples within desired window for channel 3050
wclsFrameSaver: no samples within desired window for channel 3128
wclsFrameSaver: no samples within desired window for channel 3128
wclsFrameSaver: no samples within desired window for channel 3131
wclsFrameSaver: no samples within desired window for channel 3131
FrameSaver: q=199867 n=28376 tag=wiener
%MSG-e ShowerProducedPtrsHolder:   LArPandoraModularShowerCreation:pandoraShower@BeginModule  22-Jul-2025 21:54:18 BST run: 12352 subRun: 1 event: 8855
Trying to add data product: InitialTrack. This element does not exist in the element holder
%MSG
22-Jul-2025 21:54:19 BST  Closed output file "tut_np02bde_307160012_np02_bde_coldbox_run012352_0054_20211216T000430_reco_data_2025-07-22T_195811Z.root"
DataPrepByApaModule::endJob: # events processed: 161
DataPrepByApaModule::endJob:   # events skipped: 0

===========================================================================================================================================
TimeTracker printout (sec)                                   Min           Avg           Max         Median          RMS         nEvts   
===========================================================================================================================================
Full event                                                 16.6579       17.8628       27.7792       17.7082      0.983937        161    
-------------------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput(read)                                3.1392e-05    3.57149e-05   8.7326e-05    3.4185e-05    5.77602e-06      161    
produce:caldata:DataPrepByApaModule                        6.57356       7.67652       17.6038       7.53399      0.921847        161    
produce:rns:RandomNumberSaver                            1.8894e-05    2.14249e-05   0.00013954    2.0347e-05    9.50616e-06      161    
produce:wclsdatanfsp:WireCellToolkit                       9.16275       9.74419       10.9993       9.70786      0.304471        161    
produce:gaushit:GausHitFinder                            0.00396646     0.0156926     0.0512208     0.0138908    0.00796347       161    
produce:pandora:StandardPandora                           0.0140682     0.053647      0.174558      0.0429251     0.033743        161    
produce:pandoraTrack:LArPandoraTrackCreation             9.2644e-05    0.000688405   0.00261418    0.000574515   0.000479536      161    
produce:pandoraShower:LArPandoraModularShowerCreation    0.000128729   0.00042307    0.00434308    0.000180113   0.000553142      161    
produce:pandoraStdCalo:Calorimetry                       7.8204e-05     0.000408     0.00204691    0.000328248   0.000306643      161    
produce:pandoraGnoCalo:GnocchiCalorimetry                5.1702e-05    0.000212756   0.000795553   0.000181051   0.000133162      161    
produce:pandorapid:Chi2ParticleID                         3.222e-05    3.81643e-05   0.000260283   3.5694e-05    1.81549e-05      161    
[art]:TriggerResults:TriggerResultInserter               1.0722e-05    1.21332e-05   3.5604e-05    1.1658e-05    2.78172e-06      161    
end_path:rootout:RootOutput                               2.882e-06    3.62257e-06   3.5087e-05     3.336e-06    2.64943e-06      161    
end_path:rootout:RootOutput(write)                        0.356005      0.367966      0.451421      0.366609     0.00804579       161    
===========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 3234.87 MB
  Peak resident set size usage (VmHWM): 1658.56 MB
  Details saved in: 'mem.db'
====================================================================================================
PandoraMonitoring, only able to use default TApplication (limited functionality).
PandoraMonitoring::SaveTree, error: No tree with name 'Validation' exists.
ToolBasedRawDigitPrepService:dtor: Event count: 161
ToolBasedRawDigitPrepService:dtor:  Call count: 161
ToolBasedRawDigitPrepService:dtor: Time report for 7 tools.
ToolBasedRawDigitPrepService:dtor: digitReader                   :0.01    sec/event
ToolBasedRawDigitPrepService:dtor: vdcb_adcChannelRawRmsFiller   :0.02    sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller               :0.01    sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_adcScaleAdcToKe         :0.10    sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_cnrw                    :0.02    sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder        :0.01    sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_adcScaleKeToAdc         :0.00    sec/event
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
lar exit code 0
extractor_prod.py exit code 0
pdjson2metadata exit code 0
Metadata extraction succeeds
===Metadata JSON===
{
    "metadata": {
        "DUNE.campaign": "justIN.w34s1",
        "art.file_format_era": "ART_2011a",
        "art.file_format_version": 15,
        "art.first_event": 8695,
        "art.last_event": 8855,
        "art.process_name": "VDBDEDataPrepReco",
        "art.run_type": "vd-coldbox-bottom",
        "core.application": "art.reco",
        "core.application.family": "art",
        "core.application.name": "reco",
        "core.application.version": "v09_75_00d00",
        "core.data_stream": "test",
        "core.data_tier": "full-reconstructed",
        "core.end_time": 1753217659.0,
        "core.event_count": 161,
        "core.file_format": "artroot",
        "core.file_type": "detector",
        "core.first_event_number": 8695,
        "core.last_event_number": 8855,
        "core.run_type": "vd-coldbox-bottom",
        "core.runs": [
            12352
        ],
        "core.runs_subruns": [
            1235200001
        ],
        "core.start_time": 1753214704.0
    },
    "parents": [
        {
            "did": "justin-tutorial:tut_np02bde_307160012_np02_bde_coldbox_run012352_0054_20211216T000430.hdf5"
        }
    ]
}
===================
.:
total 1683796
-rw-r--r--. 1 dune001 dune 1679297777 Jul 22 21:54 tut_np02bde_307160012_np02_bde_coldbox_run012352_0054_20211216T000430_reco_data_2025-07-22T_195811Z.root
-rw-r--r--. 1 dune001 dune   31045657 Jul 22 21:54 tut_np02bde_307160012_np02_bde_coldbox_run012352_0054_20211216T000430_reco_2025-07-22T_195811Z.log
-rw-r--r--. 1 dune001 dune   12836449 Jul 22 21:54 Pandora_Events.pndr
-rw-r--r--. 1 dune001 dune     839680 Jul 22 21:54 mem.db
-rw-r--r--. 1 dune001 dune     151552 Jul 22 21:54 time.db
-rw-r--r--. 1 dune001 dune       9851 Jul 22 21:54 jobscript.log
-rw-r--r--. 1 dune001 dune       1158 Jul 22 21:54 tut_np02bde_307160012_np02_bde_coldbox_run012352_0054_20211216T000430_reco_data_2025-07-22T_195811Z.root.json
-rw-r--r--. 1 dune001 dune        954 Jul 22 21:54 tut_np02bde_307160012_np02_bde_coldbox_run012352_0054_20211216T000430_reco_data_2025-07-22T_195811Z.root.ext.json
-rw-r--r--. 1 dune001 dune        519 Jul 22 21:54 tut_np02bde_307160012_np02_bde_coldbox_run012352_0054_20211216T000430_reco_hist.root
-rw-r--r--. 1 dune001 dune        182 Jul 22 20:58 all-input-dids.txt
-rw-r--r--. 1 dune001 dune        167 Jul 22 21:54 justin-processed-pfns.txt
-rw-r--r--. 1 dune001 dune          0 Jul 22 20:59 debugprod.log