justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID293877.26@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
SiteES_PIC
EntryDUNE_T1_ES_PIC_ce13-multicore
Last heartbeat2024-11-20 11:17:37
From worker nodeHostnametds224.pic.es
cpuinfoIntel(R) Xeon(R) CPU E5-2640 v3 @ 2.60GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes6291456000 (6000 MiB)
Wall seconds limit216000 (60 hours)
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-11-18 13:21:14
Input filesusertests:000188_reco_data_2024-11-14T_092710Z_reco_data_2024-11-14T_140600Z.root
JobscriptExit code0
Real time1d (165254s)
CPU time1d (161867s = 97%)
Outputting started2024-11-20 11:15:29
Output filesusertests:000188_reco_data_2024-11-14T_092710Z_reco_data_2024-11-14T_140600Z_reco_data_2024-11-18T_132118Z.root
Finished2024-11-20 11:17:37
Saved logsjustin-logs:293877.26-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/1c/e2/000188_reco_data_2024-11-14T_092710Z_reco_data_2024-11-14T_140600Z.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 ===
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::Reframer : 60.967762 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::Reframer : 60.887684 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::Reframer : 60.877728 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::Reframer : 60.36784 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::Reframer : 60.237865 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::Reframer : 59.49789 sec
[12:15:12.223] I [ timer  ] Timer: wcls::SimDepoSource : 40.349236 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 36.819828 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 35.430058 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 34.06029 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 33.870323 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 33.83033 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 33.60037 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::Retagger : 33.080452 sec
[12:15:12.223] I [ timer  ] Timer: wcls::FrameSaver : 32.41057 sec
[12:15:12.223] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 32.29059 sec
[12:15:12.223] I [ timer  ] Timer: Total node execution : 159006.9030570984 sec
wclsFrameSaver: saving 838 traces tagged "gauss"
FrameSaver: q=17497.7 n=9632 tag=gauss
wclsFrameSaver: saving 826 traces tagged "wiener"
FrameSaver: q=27290.3 n=9752 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
20-Nov-2024 12:15:17 CET  Closed output file "000188_reco_data_2024-11-14T_092710Z_reco_data_2024-11-14T_140600Z_reco_data_2024-11-18T_132118Z.root"
20-Nov-2024 12:15:17 CET  Closed input file "root://meitner.tier2.hep.manchester.ac.uk:1094//cephfs/experiments/dune/RSE/usertests/1c/e2/000188_reco_data_2024-11-14T_092710Z_reco_data_2024-11-14T_140600Z.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      97.2994       163.952       1920.42       168.223       74.1483       1000    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000209237    0.0252267      15.1584     0.000491822    0.481113       1000    
simulate:tpcrawdecoder:WireCellToolkit          97.2567       163.579       1899.31       168.13        73.3761       1000    
simulate:opdigi:OpDetDigitizerDUNE            0.000175909    0.266222       19.6052     0.00107326      1.20699       1000    
simulate:rns:RandomNumberSaver                2.0852e-05    3.39865e-05   0.000267374   3.1787e-05    1.06965e-05     1000    
[art]:TriggerResults:TriggerResultInserter    1.0262e-05    1.44894e-05   7.2086e-05    1.26885e-05   4.14124e-06     1000    
end_path:out1:RootOutput                       3.052e-06    5.9687e-06    3.3366e-05    5.4595e-06    1.8795e-06      1000    
end_path:out1:RootOutput(write)                0.0352729     0.0809932      4.32782      0.0433658     0.168127       1000    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 6521.55 MB
  Peak resident set size usage (VmHWM): 4696.33 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 121398782
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 775169314
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 329742361
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000188_reco_data_2024-11-14T_092710Z_reco_data_2024-11-14T_140600Z_reco_data_2024-11-18T_132118Z.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": 1732101317.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": 1731936353.0
    },
    "parents": [
        {
            "did": "usertests:000188_reco_data_2024-11-14T_092710Z_reco_data_2024-11-14T_140600Z.root"
        }
    ]
}
===================
.:
total 3089392
-rw-r--r-- 1 dune001 dune 3086926103 Nov 20 12:15 000188_reco_data_2024-11-14T_092710Z_reco_data_2024-11-14T_140600Z_reco_data_2024-11-18T_132118Z.root
-rw-r--r-- 1 dune001 dune   38602509 Nov 20 12:15 000188_reco_data_2024-11-14T_092710Z_reco_data_2024-11-14T_140600Z_reco_2024-11-18T_132118Z.log
-rw-r--r-- 1 dune001 dune   37963726 Nov 20 12:15 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r-- 1 dune001 dune       6114 Nov 20 12:15 jobscript.log
-rw-r--r-- 1 dune001 dune       1115 Nov 20 12:15 000188_reco_data_2024-11-14T_092710Z_reco_data_2024-11-14T_140600Z_reco_data_2024-11-18T_132118Z.root.json
-rw-r--r-- 1 dune001 dune        930 Nov 20 12:15 000188_reco_data_2024-11-14T_092710Z_reco_data_2024-11-14T_140600Z_reco_data_2024-11-18T_132118Z.root.ext.json
-rw-r--r-- 1 dune001 dune        164 Nov 18 14:21 all-input-dids.txt
-rw-r--r-- 1 dune001 dune        164 Nov 20 12:15 justin-processed-pfns.txt
-rw-r--r-- 1 dune001 dune          0 Nov 18 14:21 debugprod.log
justIN time: 2024-11-23 11:37:11 UTC       justIN version: 01.01.09