justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID293877.9@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:49:23
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:18:01
Input filesusertests:000560_reco_data_2024-11-14T_093206Z_reco_data_2024-11-14T_142647Z.root
JobscriptExit code0
Real time1d (167346s)
CPU time1d (163773s = 97%)
Outputting started2024-11-20 11:47:08
Output filesusertests:000560_reco_data_2024-11-14T_093206Z_reco_data_2024-11-14T_142647Z_reco_data_2024-11-18T_131810Z.root
Finished2024-11-20 11:49:23
Saved logsjustin-logs:293877.9-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/28/ce/000560_reco_data_2024-11-14T_093206Z_reco_data_2024-11-14T_142647Z.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:46:56.720] I [ timer  ] Timer: WireCell::Gen::Reframer : 68.85864 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::Reframer : 68.568665 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::Reframer : 68.51862 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::Reframer : 68.40853 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::Reframer : 68.14854 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::Reframer : 67.928444 sec
[12:46:56.720] I [ timer  ] Timer: wcls::SimDepoSource : 55.846634 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 45.07844 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 42.3789 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 42.05895 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 41.27908 sec
[12:46:56.720] I [ timer  ] Timer: wcls::FrameSaver : 41.049118 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 39.90931 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::Retagger : 39.569366 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 38.929474 sec
[12:46:56.720] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 38.259586 sec
[12:46:56.720] I [ timer  ] Timer: Total node execution : 160334.01818847656 sec
wclsFrameSaver: saving 886 traces tagged "gauss"
FrameSaver: q=18602.7 n=10314 tag=gauss
wclsFrameSaver: saving 874 traces tagged "wiener"
FrameSaver: q=28891.9 n=10427 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
20-Nov-2024 12:46:59 CET  Closed output file "000560_reco_data_2024-11-14T_093206Z_reco_data_2024-11-14T_142647Z_reco_data_2024-11-18T_131810Z.root"
20-Nov-2024 12:46:59 CET  Closed input file "root://meitner.tier2.hep.manchester.ac.uk:1094//cephfs/experiments/dune/RSE/usertests/28/ce/000560_reco_data_2024-11-14T_093206Z_reco_data_2024-11-14T_142647Z.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      102.843       165.841       2912.64       160.814       100.544       1000    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000226886    0.0253737      10.3712     0.000593406    0.345684       1000    
simulate:tpcrawdecoder:WireCellToolkit          102.802       165.431       2885.4        160.489       99.5885       1000    
simulate:opdigi:OpDetDigitizerDUNE            0.000185011    0.300588       49.9333     0.00123654      1.82708       1000    
simulate:rns:RandomNumberSaver                2.5557e-05    3.6901e-05    0.000293577   3.4528e-05    1.1431e-05      1000    
[art]:TriggerResults:TriggerResultInserter     9.264e-06    1.36904e-05   7.0962e-05    1.20115e-05   4.1623e-06      1000    
end_path:out1:RootOutput                       3.399e-06    5.82386e-06   3.2095e-05    5.4375e-06    1.76566e-06     1000    
end_path:out1:RootOutput(write)                0.0347663     0.0838945      4.14803      0.043899      0.171474       1000    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 7317.57 MB
  Peak resident set size usage (VmHWM): 5544.14 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 579147271
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 700731023
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 831148670
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000560_reco_data_2024-11-14T_093206Z_reco_data_2024-11-14T_142647Z_reco_data_2024-11-18T_131810Z.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": 1732103219.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": 1731936188.0
    },
    "parents": [
        {
            "did": "usertests:000560_reco_data_2024-11-14T_093206Z_reco_data_2024-11-14T_142647Z.root"
        }
    ]
}
===================
.:
total 3462224
-rw-r--r-- 1 dune001 dune 3468698920 Nov 20 12:46 000560_reco_data_2024-11-14T_093206Z_reco_data_2024-11-14T_142647Z_reco_data_2024-11-18T_131810Z.root
-rw-r--r-- 1 dune001 dune   38604656 Nov 20 12:47 000560_reco_data_2024-11-14T_093206Z_reco_data_2024-11-14T_142647Z_reco_2024-11-18T_131810Z.log
-rw-r--r-- 1 dune001 dune   37965885 Nov 20 12:47 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r-- 1 dune001 dune       6114 Nov 20 12:47 jobscript.log
-rw-r--r-- 1 dune001 dune       1115 Nov 20 12:47 000560_reco_data_2024-11-14T_093206Z_reco_data_2024-11-14T_142647Z_reco_data_2024-11-18T_131810Z.root.json
-rw-r--r-- 1 dune001 dune        930 Nov 20 12:47 000560_reco_data_2024-11-14T_093206Z_reco_data_2024-11-14T_142647Z_reco_data_2024-11-18T_131810Z.root.ext.json
-rw-r--r-- 1 dune001 dune        164 Nov 18 14:18 all-input-dids.txt
-rw-r--r-- 1 dune001 dune        164 Nov 20 12:47 justin-processed-pfns.txt
-rw-r--r-- 1 dune001 dune          0 Nov 18 14:18 debugprod.log
justIN time: 2024-11-23 11:54:53 UTC       justIN version: 01.01.09