justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID101168.14@justin-prod-sched02.dune.hep.ac.uk
Workflow ID4131
Stage ID1
User nameamoor@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
RSS bytes6291456000 (6000 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2024-11-18 12:54:05
SiteUK_Imperial
EntryDUNE_T2_UK_London_IC_ceprod00
Last heartbeat2024-11-19 23:23:18
From worker nodeHostnamewn03.grid.hep.ph.ic.ac.uk
cpuinfoAMD EPYC 7742 64-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes6291456000 (6000 MiB)
Wall seconds limit171000 (47 hours)
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-11-18 12:55:32
Input filesusertests:000656_reco_data_2024-11-14T_093303Z_reco_data_2024-11-14T_142543Z.root
JobscriptExit code0
Real time1d (123977s)
CPU time1d (113874s = 91%)
Outputting started2024-11-19 23:21:49
Output filesusertests:000656_reco_data_2024-11-14T_093303Z_reco_data_2024-11-14T_142543Z_reco_data_2024-11-18T_125550Z.root
Finished2024-11-19 23:23:18
Saved logsjustin-logs:101168.14-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

AFM detsim jobscript.
Input PFN = root://meitner.tier2.hep.manchester.ac.uk:1094//cephfs/experiments/dune/RSE/usertests/d4/af/000656_reco_data_2024-11-14T_093303Z_reco_data_2024-11-14T_142543Z.root
Setting up larsoft UPS area... /cvmfs/larsoft.opensciencegrid.org
Setting up DUNE UPS area... /cvmfs/dune.opensciencegrid.org/products/dune/
/cvmfs/larsoft.opensciencegrid.org/products/xrootd/v5_4_3b/Linux64bit+3.10-2.17-e20-p3913-prof/lib/libXrdPosixPreload.so
=== Start last 50 lines of lar log file ===
[23:21:34.806] I [ timer  ] Timer: WireCell::Gen::Reframer : 87.40015 sec
[23:21:34.806] I [ timer  ] Timer: WireCell::Gen::Reframer : 87.330086 sec
[23:21:34.806] I [ timer  ] Timer: WireCell::Gen::Reframer : 87.20012 sec
[23:21:34.807] I [ timer  ] Timer: WireCell::Gen::Reframer : 87.020035 sec
[23:21:34.807] I [ timer  ] Timer: WireCell::Gen::Reframer : 86.6899 sec
[23:21:34.807] I [ timer  ] Timer: WireCell::Gen::Reframer : 85.73971 sec
[23:21:34.807] I [ timer  ] Timer: wcls::SimDepoSource : 80.538795 sec
[23:21:34.807] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 68.43621 sec
[23:21:34.807] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 64.1453 sec
[23:21:34.807] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 63.99528 sec
[23:21:34.807] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 63.245396 sec
[23:21:34.807] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 63.115417 sec
[23:21:34.807] I [ timer  ] Timer: WireCell::Gen::Retagger : 62.825462 sec
[23:21:34.807] I [ timer  ] Timer: wcls::FrameSaver : 62.53551 sec
[23:21:34.807] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 62.435528 sec
[23:21:34.807] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 60.055927 sec
[23:21:34.807] I [ timer  ] Timer: Total node execution : 108819.75960922241 sec
wclsFrameSaver: saving 918 traces tagged "gauss"
FrameSaver: q=18665.5 n=10581 tag=gauss
wclsFrameSaver: saving 895 traces tagged "wiener"
FrameSaver: q=29300.2 n=10649 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
19-Nov-2024 23:21:35 GMT  Closed output file "000656_reco_data_2024-11-14T_093303Z_reco_data_2024-11-14T_142543Z_reco_data_2024-11-18T_125550Z.root"
19-Nov-2024 23:21:35 GMT  Closed input file "root://meitner.tier2.hep.manchester.ac.uk:1094//cephfs/experiments/dune/RSE/usertests/d4/af/000656_reco_data_2024-11-14T_093303Z_reco_data_2024-11-14T_142543Z.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      84.493        123.154       5264.35       110.259       184.074       1000    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000237002   0.00889186     0.613039     0.000837618    0.0417861      1000    
simulate:tpcrawdecoder:WireCellToolkit          84.442        122.853       5217.51       110.057       182.475       1000    
simulate:opdigi:OpDetDigitizerDUNE            0.00023575     0.179589       41.5309     0.000984428     1.42476       1000    
simulate:rns:RandomNumberSaver                2.4736e-05    3.82087e-05   0.000304939   3.4925e-05    1.79206e-05     1000    
[art]:TriggerResults:TriggerResultInserter    1.1732e-05    1.93678e-05   0.000334736   1.69215e-05   1.94184e-05     1000    
end_path:out1:RootOutput                       5.35e-06     8.39758e-06   0.000128941    7.293e-06    9.52857e-06     1000    
end_path:out1:RootOutput(write)                0.0474189     0.111894       5.31523      0.0765466     0.220581       1000    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 7286.02 MB
  Peak resident set size usage (VmHWM): 5498.18 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 238766127
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 888286151
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 491071133
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000656_reco_data_2024-11-14T_093303Z_reco_data_2024-11-14T_142543Z_reco_data_2024-11-18T_125550Z.root
extractor_prod.py exit code 0
pdjson2metadata exit code 0
Metadata extraction succeeds
===Metadata JSON===
{
    "metadata": {
        "DUNE.campaign": "justIN.w4131s1",
        "art.file_format_era": "ART_2011a",
        "art.file_format_version": 15,
        "art.first_event": 1,
        "art.last_event": 1000,
        "art.process_name": "detsim",
        "art.run_type": "physics",
        "core.application": "art.reco",
        "core.application.family": "art",
        "core.application.name": "reco",
        "core.application.version": "v09_75_03d00",
        "core.data_stream": "out1",
        "core.data_tier": "detector-simulated",
        "core.end_time": 1732058495.0,
        "core.event_count": 1000,
        "core.file_format": "artroot",
        "core.file_type": "mc",
        "core.first_event_number": 1,
        "core.last_event_number": 1000,
        "core.run_type": "physics",
        "core.runs": [
            20000031
        ],
        "core.runs_subruns": [
            2000003100000
        ],
        "core.start_time": 1731934767.0
    },
    "parents": [
        {
            "did": "usertests:000656_reco_data_2024-11-14T_093303Z_reco_data_2024-11-14T_142543Z.root"
        }
    ]
}
===================
.:
total 3378324
-rw-r--r--. 1 job0021 job0021 3382793557 Nov 19 23:21 000656_reco_data_2024-11-14T_093303Z_reco_data_2024-11-14T_142543Z_reco_data_2024-11-18T_125550Z.root
-rw-r--r--. 1 job0021 job0021   38602350 Nov 19 23:21 000656_reco_data_2024-11-14T_093303Z_reco_data_2024-11-14T_142543Z_reco_2024-11-18T_125550Z.log
-rw-r--r--. 1 job0021 job0021   37963311 Nov 19 23:21 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r--. 1 job0021 job0021       6114 Nov 19 23:21 jobscript.log
-rw-r--r--. 1 job0021 job0021       1115 Nov 19 23:21 000656_reco_data_2024-11-14T_093303Z_reco_data_2024-11-14T_142543Z_reco_data_2024-11-18T_125550Z.root.json
-rw-r--r--. 1 job0021 job0021        930 Nov 19 23:21 000656_reco_data_2024-11-14T_093303Z_reco_data_2024-11-14T_142543Z_reco_data_2024-11-18T_125550Z.root.ext.json
-rw-r--r--. 1 job0021 job0021        164 Nov 18 12:55 all-input-dids.txt
-rw-r--r--. 1 job0021 job0021        164 Nov 19 23:21 justin-processed-pfns.txt
-rw-r--r--. 1 job0021 job0021          0 Nov 18 12:56 debugprod.log
justIN time: 2024-11-24 04:16:48 UTC       justIN version: 01.01.09