justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 293877.43@justin-prod-sched01.dune.hep.ac.uk

Jobsub ID293877.43@justin-prod-sched01.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:58:38
SiteUK_Manchester
EntryUBoone_T2_UK_Manchester_ce01
Last heartbeat2024-11-20 03:42:40
From worker nodeHostnamewn2205250.tier2.hep.manchester.ac.uk
cpuinfoAMD EPYC 7513 32-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes6291456000 (6000 MiB)
Wall seconds limit257400 (71 hours)
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-11-18 13:25:44
Input filesusertests:000475_reco_data_2024-11-14T_093059Z_reco_data_2024-11-14T_135555Z.root
JobscriptExit code0
Real time1d (137723s)
CPU time1d (133421s = 96%)
Outputting started2024-11-20 03:41:07
Output filesusertests:000475_reco_data_2024-11-14T_093059Z_reco_data_2024-11-14T_135555Z_reco_data_2024-11-18T_132549Z.root
Finished2024-11-20 03:42:40
Saved logsjustin-logs:293877.43-justin-prod-sched01.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/01/57/000475_reco_data_2024-11-14T_093059Z_reco_data_2024-11-14T_135555Z.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 ===
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::Reframer : 91.33908 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::Reframer : 91.17906 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::Reframer : 90.629005 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::Reframer : 90.50886 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::Reframer : 90.47886 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::Reframer : 89.838806 sec
[03:40:48.226] I [ timer  ] Timer: wcls::SimDepoSource : 75.56774 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 67.756065 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 60.735832 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 60.195934 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 59.735985 sec
[03:40:48.226] I [ timer  ] Timer: wcls::FrameSaver : 57.806305 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 57.65633 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 57.00644 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::Retagger : 56.28656 sec
[03:40:48.226] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 55.4467 sec
[03:40:48.226] I [ timer  ] Timer: Total node execution : 128757.9231338501 sec
wclsFrameSaver: saving 16984 traces tagged "gauss"
FrameSaver: q=5.24769e+06 n=294876 tag=gauss
wclsFrameSaver: saving 22108 traces tagged "wiener"
FrameSaver: q=5.91842e+06 n=266376 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
20-Nov-2024 03:40:54 GMT  Closed output file "000475_reco_data_2024-11-14T_093059Z_reco_data_2024-11-14T_135555Z_reco_data_2024-11-18T_132549Z.root"
20-Nov-2024 03:40:54 GMT  Closed input file "root://meitner.tier2.hep.manchester.ac.uk:1094//cephfs/experiments/dune/RSE/usertests/01/57/000475_reco_data_2024-11-14T_093059Z_reco_data_2024-11-14T_135555Z.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      95.1944       136.992       4744.2        122.47        162.028       1000    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000323789    0.0442202       12.76      0.000793678    0.578583       1000    
simulate:tpcrawdecoder:WireCellToolkit          95.1262       136.69        4726.83       122.363       161.361       1000    
simulate:opdigi:OpDetDigitizerDUNE            0.000371158    0.147288       13.8071     0.00330568     0.577881       1000    
simulate:rns:RandomNumberSaver                2.4846e-05    6.42972e-05   0.00416593    5.7403e-05    0.000131085     1000    
[art]:TriggerResults:TriggerResultInserter     1.063e-05    2.12099e-05   0.000135485   1.96065e-05   7.59958e-06     1000    
end_path:out1:RootOutput                       3.937e-06    8.95947e-06   5.1427e-05     8.416e-06    2.9854e-06      1000    
end_path:out1:RootOutput(write)                0.0375466     0.109937       3.56155      0.0680662     0.172181       1000    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 7127.22 MB
  Peak resident set size usage (VmHWM): 5090.14 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 702802141
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 285541205
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 591542593
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000475_reco_data_2024-11-14T_093059Z_reco_data_2024-11-14T_135555Z_reco_data_2024-11-18T_132549Z.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": 1732074054.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": 1731936595.0
    },
    "parents": [
        {
            "did": "usertests:000475_reco_data_2024-11-14T_093059Z_reco_data_2024-11-14T_135555Z.root"
        }
    ]
}
===================
.:
total 3344764
-rw-r--r-- 1 dune01 dune01 3348411411 Nov 20 03:40 000475_reco_data_2024-11-14T_093059Z_reco_data_2024-11-14T_135555Z_reco_data_2024-11-18T_132549Z.root
-rw-r--r-- 1 dune01 dune01   38612405 Nov 20 03:40 000475_reco_data_2024-11-14T_093059Z_reco_data_2024-11-14T_135555Z_reco_2024-11-18T_132549Z.log
-rw-r--r-- 1 dune01 dune01   37972931 Nov 20 03:40 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r-- 1 dune01 dune01       6127 Nov 20 03:41 jobscript.log
-rw-r--r-- 1 dune01 dune01       1115 Nov 20 03:41 000475_reco_data_2024-11-14T_093059Z_reco_data_2024-11-14T_135555Z_reco_data_2024-11-18T_132549Z.root.json
-rw-r--r-- 1 dune01 dune01        930 Nov 20 03:41 000475_reco_data_2024-11-14T_093059Z_reco_data_2024-11-14T_135555Z_reco_data_2024-11-18T_132549Z.root.ext.json
-rw-r--r-- 1 dune01 dune01        164 Nov 18 13:25 all-input-dids.txt
-rw-r--r-- 1 dune01 dune01        164 Nov 20 03:41 justin-processed-pfns.txt
-rw-r--r-- 1 dune01 dune01          0 Nov 18 13:26 debugprod.log
justIN time: 2024-11-23 11:53:32 UTC       justIN version: 01.01.09