Jobsub ID 298830.12@dunegpschedd01.fnal.gov

Jobsub ID	298830.12@dunegpschedd01.fnal.gov
Workflow ID	12211
Stage ID	1
User name	jqin1@fnal.gov
Requested	Processors	1
	GPU	No
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2026-01-22 00:22:20
Site	UK_QMUL
Entry	DUNE_UK_London_QMUL_arcce02
Last heartbeat	2026-01-22 00:33:59
From worker node	Hostname	cn036.htc.esc.qmul
	cpuinfo	Intel(R) Xeon(R) Gold 6248R CPU @ 3.00GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	171000 (47 hours)
	GPU
	Inner Apptainer?	True
Job state	finished
Started	2026-01-22 00:23:58
Input files	justin-tutorial:tut_np02bde_307160127_np02_bde_coldbox_run012352_0053_20211216T000148.hdf5
Jobscript	Exit code	0
	Real time	4m (274s)
	CPU time	3m (223s = 81%)
	Max RSS bytes	1768955904 (1687 MiB)
Outputting started	2026-01-22 00:28:33
Output files	usertests:tut_np02bde_307160127_np02_bde_coldbox_run012352_0053_20211216T000148_reco_data_2026-01-22T_002403Z.root
Finished	2026-01-22 00:33:57
Saved logs	justin-logs:298830.12-dunegpschedd01.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

lsFrameSaver: no samples within desired window for channel 2987
wclsFrameSaver: no samples within desired window for channel 2988
wclsFrameSaver: no samples within desired window for channel 2988
wclsFrameSaver: no samples within desired window for channel 2988
wclsFrameSaver: no samples within desired window for channel 2988
wclsFrameSaver: no samples within desired window for channel 2988
wclsFrameSaver: no samples within desired window for channel 2988
wclsFrameSaver: no samples within desired window for channel 2989
wclsFrameSaver: no samples within desired window for channel 2989
wclsFrameSaver: no samples within desired window for channel 2989
wclsFrameSaver: no samples within desired window for channel 2989
wclsFrameSaver: no samples within desired window for channel 2989
wclsFrameSaver: no samples within desired window for channel 2989
wclsFrameSaver: no samples within desired window for channel 2990
wclsFrameSaver: no samples within desired window for channel 2990
wclsFrameSaver: no samples within desired window for channel 2990
wclsFrameSaver: no samples within desired window for channel 2990
wclsFrameSaver: no samples within desired window for channel 2990
wclsFrameSaver: no samples within desired window for channel 2990
wclsFrameSaver: no samples within desired window for channel 2992
wclsFrameSaver: no samples within desired window for channel 2992
wclsFrameSaver: no samples within desired window for channel 2992
wclsFrameSaver: no samples within desired window for channel 2992
wclsFrameSaver: no samples within desired window for channel 2992
wclsFrameSaver: no samples within desired window for channel 2992
wclsFrameSaver: no samples within desired window for channel 2993
wclsFrameSaver: no samples within desired window for channel 2993
wclsFrameSaver: no samples within desired window for channel 2993
wclsFrameSaver: no samples within desired window for channel 2993
wclsFrameSaver: no samples within desired window for channel 2994
wclsFrameSaver: no samples within desired window for channel 2994
wclsFrameSaver: no samples within desired window for channel 2994
wclsFrameSaver: no samples within desired window for channel 2994
wclsFrameSaver: no samples within desired window for channel 3007
wclsFrameSaver: no samples within desired window for channel 3007
wclsFrameSaver: no samples within desired window for channel 3037
wclsFrameSaver: no samples within desired window for channel 3037
wclsFrameSaver: no samples within desired window for channel 3169
wclsFrameSaver: no samples within desired window for channel 3169
FrameSaver: q=195019 n=21893 tag=wiener
%MSG-e ShowerProducedPtrsHolder:   LArPandoraModularShowerCreation:pandoraShower@BeginModule  22-Jan-2026 00:28:22 GMT run: 12352 subRun: 1 event: 8534
Trying to add data product: InitialTrack. This element does not exist in the element holder
%MSG
22-Jan-2026 00:28:22 GMT  Opened output file with pattern "tut_np02bde_307160127_np02_bde_coldbox_run012352_0053_20211216T000148_reco_data_2026-01-22T_002403Z.root"
22-Jan-2026 00:28:27 GMT  Closed output file "tut_np02bde_307160127_np02_bde_coldbox_run012352_0053_20211216T000148_reco_data_2026-01-22T_002403Z.root"
DataPrepByApaModule::endJob: # events processed: 1
DataPrepByApaModule::endJob:   # events skipped: 0

===========================================================================================================================================
TimeTracker printout (sec)                                   Min           Avg           Max         Median          RMS         nEvts   
===========================================================================================================================================
Full event                                                 19.4352       19.4352       19.4352       19.4352          0            1     
-------------------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput(read)                                0.000221686   0.000221686   0.000221686   0.000221686        0            1     
produce:caldata:DataPrepByApaModule                        1.61472       1.61472       1.61472       1.61472          0            1     
produce:rns:RandomNumberSaver                            0.000242801   0.000242801   0.000242801   0.000242801        0            1     
produce:wclsdatanfsp:WireCellToolkit                       16.8793       16.8793       16.8793       16.8793          0            1     
produce:gaushit:GausHitFinder                             0.0329709     0.0329709     0.0329709     0.0329709         0            1     
produce:pandora:StandardPandora                           0.160493      0.160493      0.160493      0.160493          0            1     
produce:pandoraTrack:LArPandoraTrackCreation             0.00600694    0.00600694    0.00600694    0.00600694         0            1     
produce:pandoraShower:LArPandoraModularShowerCreation    0.00897601    0.00897601    0.00897601    0.00897601         0            1     
produce:pandoraStdCalo:Calorimetry                       0.00459733    0.00459733    0.00459733    0.00459733         0            1     
produce:pandoraGnoCalo:GnocchiCalorimetry                0.00176846    0.00176846    0.00176846    0.00176846         0            1     
produce:pandorapid:Chi2ParticleID                        0.000513394   0.000513394   0.000513394   0.000513394        0            1     
[art]:TriggerResults:TriggerResultInserter               5.9395e-05    5.9395e-05    5.9395e-05    5.9395e-05         0            1     
end_path:rootout:RootOutput                              2.1537e-05    2.1537e-05    2.1537e-05    2.1537e-05         0            1     
end_path:rootout:RootOutput(write)                        0.721749      0.721749      0.721749      0.721749          0            1     
===========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 3029.82 MB
  Peak resident set size usage (VmHWM): 1768.96 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: 1
ToolBasedRawDigitPrepService:dtor:  Call count: 1
ToolBasedRawDigitPrepService:dtor: Time report for 7 tools.
ToolBasedRawDigitPrepService:dtor: digitReader                   :0.02    sec/event
ToolBasedRawDigitPrepService:dtor: vdcb_adcChannelRawRmsFiller   :0.11    sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller               :0.01    sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_adcScaleAdcToKe         :0.24    sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_cnrw                    :0.05    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.w12211s1",
        "art.file_format_era": "ART_2011a",
        "art.file_format_version": 15,
        "art.first_event": 8534,
        "art.last_event": 8534,
        "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": 1769041706.0,
        "core.event_count": 1,
        "core.file_format": "artroot",
        "core.file_type": "detector",
        "core.first_event_number": 8534,
        "core.last_event_number": 8534,
        "core.run_type": "vd-coldbox-bottom",
        "core.runs": [
            12352
        ],
        "core.runs_subruns": [
            1235200001
        ],
        "core.start_time": 1769041702.0
    },
    "parents": [
        {
            "did": "justin-tutorial:tut_np02bde_307160127_np02_bde_coldbox_run012352_0053_20211216T000148.hdf5"
        }
    ]
}
===================
.:
total 10976
-rw-r--r-- 1 pildune22 pildune 10839962 Jan 22 00:28 tut_np02bde_307160127_np02_bde_coldbox_run012352_0053_20211216T000148_reco_data_2026-01-22T_002403Z.root
-rw-r--r-- 1 pildune22 pildune   204101 Jan 22 00:28 tut_np02bde_307160127_np02_bde_coldbox_run012352_0053_20211216T000148_reco_2026-01-22T_002403Z.log
-rw-r--r-- 1 pildune22 pildune    99557 Jan 22 00:28 Pandora_Events.pndr
-rw-r--r-- 1 pildune22 pildune    40960 Jan 22 00:28 mem.db
-rw-r--r-- 1 pildune22 pildune    16384 Jan 22 00:28 time.db
-rw-r--r-- 1 pildune22 pildune     9951 Jan 22 00:28 jobscript.log
-rw-r--r-- 1 pildune22 pildune     1159 Jan 22 00:28 tut_np02bde_307160127_np02_bde_coldbox_run012352_0053_20211216T000148_reco_data_2026-01-22T_002403Z.root.json
-rw-r--r-- 1 pildune22 pildune      953 Jan 22 00:28 tut_np02bde_307160127_np02_bde_coldbox_run012352_0053_20211216T000148_reco_data_2026-01-22T_002403Z.root.ext.json
-rw-r--r-- 1 pildune22 pildune      519 Jan 22 00:28 tut_np02bde_307160127_np02_bde_coldbox_run012352_0053_20211216T000148_reco_hist.root
-rw-r--r-- 1 pildune22 pildune      182 Jan 22 00:23 all-input-dids.txt
-rw-r--r-- 1 pildune22 pildune      173 Jan 22 00:28 justin-processed-pfns.txt
-rw-r--r-- 1 pildune22 pildune        0 Jan 22 00:25 debugprod.log