Jobsub ID 83616.2@justin-prod-sched02.dune.hep.ac.uk

Jobsub ID	83616.2@justin-prod-sched02.dune.hep.ac.uk
Workflow ID	503
Stage ID	1
User name	amcnab@fnal.gov
HTCondor Group	group_dune
Requested	Processors	1
	GPU	No
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2024-10-18 14:39:13
Site	UK_Imperial
Entry	DUNE_T2_UK_London_IC_ceprod03
Last heartbeat	2024-10-18 14:48:06
From worker node	Hostname	wj35.grid.hep.ph.ic.ac.uk
	cpuinfo	Intel(R) Xeon(R) CPU E5-2620 v4 @ 2.10GHz
	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
Allocator name	justin-allocator-int.dune.hep.ac.uk
Started	2024-10-18 14:40:45
Input files	justin-tutorial:tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954.hdf5
Jobscript	Exit code	0
	Real time	5m (331s)
	CPU time	4m (286s = 86%)
Outputting started	2024-10-18 14:46:17
Output files	usertests:tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_data_2024-10-18T_144058Z.root
Finished	2024-10-18 14:48:06
Saved logs	justin-logs:83616.2-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events Wrapper job log

Jobscript log (last 10,000 characters)

sFrameSaver: no samples within desired window for channel 3110
wclsFrameSaver: no samples within desired window for channel 3110
wclsFrameSaver: no samples within desired window for channel 3110
wclsFrameSaver: no samples within desired window for channel 3110
wclsFrameSaver: no samples within desired window for channel 3110
wclsFrameSaver: no samples within desired window for channel 3110
wclsFrameSaver: no samples within desired window for channel 3110
wclsFrameSaver: no samples within desired window for channel 3111
wclsFrameSaver: no samples within desired window for channel 3111
wclsFrameSaver: no samples within desired window for channel 3111
wclsFrameSaver: no samples within desired window for channel 3111
wclsFrameSaver: no samples within desired window for channel 3111
wclsFrameSaver: no samples within desired window for channel 3111
wclsFrameSaver: no samples within desired window for channel 3111
wclsFrameSaver: no samples within desired window for channel 3111
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3112
wclsFrameSaver: no samples within desired window for channel 3113
wclsFrameSaver: no samples within desired window for channel 3113
wclsFrameSaver: no samples within desired window for channel 3113
wclsFrameSaver: no samples within desired window for channel 3113
wclsFrameSaver: no samples within desired window for channel 3113
wclsFrameSaver: no samples within desired window for channel 3113
wclsFrameSaver: no samples within desired window for channel 3113
wclsFrameSaver: no samples within desired window for channel 3113
wclsFrameSaver: no samples within desired window for channel 3114
wclsFrameSaver: no samples within desired window for channel 3114
wclsFrameSaver: no samples within desired window for channel 3154
wclsFrameSaver: no samples within desired window for channel 3154
FrameSaver: q=177349 n=10254 tag=wiener
18-Oct-2024 15:46:02 BST  Opened output file with pattern "tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_data_2024-10-18T_144058Z.root"
18-Oct-2024 15:46:07 BST  Closed output file "tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_data_2024-10-18T_144058Z.root"
DataPrepByApaModule::endJob: # events processed: 1
DataPrepByApaModule::endJob:   # events skipped: 0

===========================================================================================================================================
TimeTracker printout (sec)                                   Min           Avg           Max         Median          RMS         nEvts   
===========================================================================================================================================
Full event                                                 24.8279       24.8279       24.8279       24.8279          0            1     
-------------------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput(read)                                0.000246119   0.000246119   0.000246119   0.000246119        0            1     
produce:caldata:DataPrepByApaModule                        4.59151       4.59151       4.59151       4.59151          0            1     
produce:rns:RandomNumberSaver                            0.000253456   0.000253456   0.000253456   0.000253456        0            1     
produce:wclsdatanfsp:WireCellToolkit                       19.0328       19.0328       19.0328       19.0328          0            1     
produce:gaushit:GausHitFinder                             0.0313438     0.0313438     0.0313438     0.0313438         0            1     
produce:pandora:StandardPandora                           0.165782      0.165782      0.165782      0.165782          0            1     
produce:pandoraTrack:LArPandoraTrackCreation             0.00548013    0.00548013    0.00548013    0.00548013         0            1     
produce:pandoraShower:LArPandoraModularShowerCreation    0.00216513    0.00216513    0.00216513    0.00216513         0            1     
produce:pandoraStdCalo:Calorimetry                       0.00418388    0.00418388    0.00418388    0.00418388         0            1     
produce:pandoraGnoCalo:GnocchiCalorimetry                0.00138011    0.00138011    0.00138011    0.00138011         0            1     
produce:pandorapid:Chi2ParticleID                        0.000501974   0.000501974   0.000501974   0.000501974        0            1     
[art]:TriggerResults:TriggerResultInserter               5.8512e-05    5.8512e-05    5.8512e-05    5.8512e-05         0            1     
end_path:rootout:RootOutput                              2.1688e-05    2.1688e-05    2.1688e-05    2.1688e-05         0            1     
end_path:rootout:RootOutput(write)                        0.989371      0.989371      0.989371      0.989371          0            1     
===========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 3006.87 MB
  Peak resident set size usage (VmHWM): 1778.18 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.03    sec/event
ToolBasedRawDigitPrepService:dtor: vdcb_adcChannelRawRmsFiller   :0.10    sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller               :0.01    sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_adcScaleAdcToKe         :0.25    sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_cnrw                    :0.06    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.w503s1",
        "art.file_format_era": "ART_2011a",
        "art.file_format_version": 15,
        "art.first_event": 9017,
        "art.last_event": 9017,
        "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": 1729262767.0,
        "core.event_count": 1,
        "core.file_format": "artroot",
        "core.file_type": "detector",
        "core.first_event_number": 9017,
        "core.last_event_number": 9017,
        "core.run_type": "vd-coldbox-bottom",
        "core.runs": [
            12352
        ],
        "core.runs_subruns": [
            1235200001
        ],
        "core.start_time": 1729262762.0
    },
    "parents": [
        {
            "did": "justin-tutorial:tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954.hdf5"
        }
    ]
}
===================
.:
total 10900
-rw-r--r--. 1 job0002 job0002 10726142 Oct 18 15:46 tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_data_2024-10-18T_144058Z.root
-rw-r--r--. 1 job0002 job0002   256723 Oct 18 15:46 tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_2024-10-18T_144058Z.log
-rw-r--r--. 1 job0002 job0002    78011 Oct 18 15:46 Pandora_Events.pndr
-rw-r--r--. 1 job0002 job0002    40960 Oct 18 15:46 mem.db
-rw-r--r--. 1 job0002 job0002    16384 Oct 18 15:46 time.db
-rw-r--r--. 1 job0002 job0002     9898 Oct 18 15:46 jobscript.log
-rw-r--r--. 1 job0002 job0002     1157 Oct 18 15:46 tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_data_2024-10-18T_144058Z.root.json
-rw-r--r--. 1 job0002 job0002      951 Oct 18 15:46 tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_data_2024-10-18T_144058Z.root.ext.json
-rw-r--r--. 1 job0002 job0002      519 Oct 18 15:46 tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_hist.root
-rw-r--r--. 1 job0002 job0002      182 Oct 18 15:40 all-input-dids.txt
-rw-r--r--. 1 job0002 job0002      173 Oct 18 15:46 justin-processed-pfns.txt
-rw-r--r--. 1 job0002 job0002        0 Oct 18 15:43 debugprod.log