justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID293869.40@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:52:58
SiteES_PIC
EntryDUNE_T1_ES_PIC_ce13-multicore
Last heartbeat2024-11-20 08:02:20
From worker nodeHostnametds226.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 12:57:41
Input filesusertests:000763_reco_data_2024-11-14T_093420Z_reco_data_2024-11-14T_142423Z.root
JobscriptExit code0
Real time1d (154976s)
CPU time1d (152116s = 98%)
Outputting started2024-11-20 08:00:38
Output filesusertests:000763_reco_data_2024-11-14T_093420Z_reco_data_2024-11-14T_142423Z_reco_data_2024-11-18T_125835Z.root
Finished2024-11-20 08:02:20
Saved logsjustin-logs:293869.40-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/a1/28/000763_reco_data_2024-11-14T_093420Z_reco_data_2024-11-14T_142423Z.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 ===
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::Reframer : 44.62962 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::Reframer : 44.539654 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::Reframer : 44.33964 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::Reframer : 44.279606 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::Reframer : 44.079643 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::Reframer : 44.039623 sec
[09:00:18.782] I [ timer  ] Timer: wcls::SimDepoSource : 25.820496 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 23.500443 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 20.460373 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 19.800358 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 19.510351 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 19.42035 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 18.850336 sec
[09:00:18.782] I [ timer  ] Timer: wcls::FrameSaver : 18.020317 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::Retagger : 17.960316 sec
[09:00:18.782] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 17.510305 sec
[09:00:18.782] I [ timer  ] Timer: Total node execution : 150395.27604866028 sec
wclsFrameSaver: saving 3064 traces tagged "gauss"
FrameSaver: q=441129 n=46005 tag=gauss
wclsFrameSaver: saving 3885 traces tagged "wiener"
FrameSaver: q=475445 n=40955 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
20-Nov-2024 09:00:24 CET  Closed output file "000763_reco_data_2024-11-14T_093420Z_reco_data_2024-11-14T_142423Z_reco_data_2024-11-18T_125835Z.root"
20-Nov-2024 09:00:24 CET  Closed input file "root://meitner.tier2.hep.manchester.ac.uk:1094//cephfs/experiments/dune/RSE/usertests/a1/28/000763_reco_data_2024-11-14T_093420Z_reco_data_2024-11-14T_142423Z.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      94.6258       153.745       357.476       142.32        40.6815       1000    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000221591    0.0138518      2.9213      0.000436564    0.111508       1000    
simulate:tpcrawdecoder:WireCellToolkit          94.5908       153.474       354.387       141.938       40.5383       1000    
simulate:opdigi:OpDetDigitizerDUNE            0.000180588    0.185655       3.61519     0.000825751     0.38186       1000    
simulate:rns:RandomNumberSaver                1.6237e-05    3.50559e-05   0.000343579   3.22725e-05   1.32528e-05     1000    
[art]:TriggerResults:TriggerResultInserter     9.334e-06    1.51131e-05   9.3897e-05    1.3501e-05    4.75255e-06     1000    
end_path:out1:RootOutput                       2.457e-06    5.49852e-06    3.289e-05     5.146e-06    1.9249e-06      1000    
end_path:out1:RootOutput(write)                0.0333106     0.0706272      0.83001      0.0420787     0.0741257      1000    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 3973.97 MB
  Peak resident set size usage (VmHWM): 2118.48 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 527717431
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 634596757
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 144375530
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000763_reco_data_2024-11-14T_093420Z_reco_data_2024-11-14T_142423Z_reco_data_2024-11-18T_125835Z.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": 1732089624.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": 1731935093.0
    },
    "parents": [
        {
            "did": "usertests:000763_reco_data_2024-11-14T_093420Z_reco_data_2024-11-14T_142423Z.root"
        }
    ]
}
===================
.:
total 2192364
-rw-r--r-- 1 dune001 dune 2168364765 Nov 20 09:00 000763_reco_data_2024-11-14T_093420Z_reco_data_2024-11-14T_142423Z_reco_data_2024-11-18T_125835Z.root
-rw-r--r-- 1 dune001 dune   38605095 Nov 20 09:00 000763_reco_data_2024-11-14T_093420Z_reco_data_2024-11-14T_142423Z_reco_2024-11-18T_125835Z.log
-rw-r--r-- 1 dune001 dune   37966077 Nov 20 09:00 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r-- 1 dune001 dune       6121 Nov 20 09:00 jobscript.log
-rw-r--r-- 1 dune001 dune       1115 Nov 20 09:00 000763_reco_data_2024-11-14T_093420Z_reco_data_2024-11-14T_142423Z_reco_data_2024-11-18T_125835Z.root.json
-rw-r--r-- 1 dune001 dune        930 Nov 20 09:00 000763_reco_data_2024-11-14T_093420Z_reco_data_2024-11-14T_142423Z_reco_data_2024-11-18T_125835Z.root.ext.json
-rw-r--r-- 1 dune001 dune        164 Nov 18 13:57 all-input-dids.txt
-rw-r--r-- 1 dune001 dune        164 Nov 20 09:00 justin-processed-pfns.txt
-rw-r--r-- 1 dune001 dune          0 Nov 18 13:59 debugprod.log
justIN time: 2024-11-23 11:54:00 UTC       justIN version: 01.01.09