Jobsub ID 293869.109@justin-prod-sched01.dune.hep.ac.uk
Jobscript log (last 10,000 characters)
AFM detsim jobscript.
Input PFN = root://xrootd.echo.stfc.ac.uk:1094/dune:/protodune/RSE/usertests/9f/51/000988_reco_data_2024-11-14T_093623Z_reco_data_2024-11-14T_142649Z.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 ===
[17:27:03.817] I [ timer ] Timer: WireCell::Gen::Reframer : 81.5409 sec
[17:27:03.817] I [ timer ] Timer: WireCell::Gen::Reframer : 81.3008 sec
[17:27:03.817] I [ timer ] Timer: WireCell::Gen::Reframer : 80.960724 sec
[17:27:03.817] I [ timer ] Timer: WireCell::Gen::Reframer : 80.92076 sec
[17:27:03.817] I [ timer ] Timer: WireCell::Gen::Reframer : 80.28053 sec
[17:27:03.817] I [ timer ] Timer: WireCell::Gen::Reframer : 79.83043 sec
[17:27:03.818] I [ timer ] Timer: WireCell::Gen::Reframer : 79.8105 sec
[17:27:03.818] I [ timer ] Timer: WireCell::Gen::DumpFrames : 54.92679 sec
[17:27:03.818] I [ timer ] Timer: WireCell::Gen::FrameFanin : 46.168255 sec
[17:27:03.818] I [ timer ] Timer: WireCell::Gen::FrameFanin : 46.12827 sec
[17:27:03.818] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 44.868477 sec
[17:27:03.818] I [ timer ] Timer: WireCell::Gen::FrameFanin : 44.658516 sec
[17:27:03.818] I [ timer ] Timer: WireCell::Gen::Retagger : 43.978626 sec
[17:27:03.818] I [ timer ] Timer: wcls::FrameSaver : 43.228752 sec
[17:27:03.818] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 42.75883 sec
[17:27:03.818] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 41.399063 sec
[17:27:03.818] I [ timer ] Timer: Total node execution : 180057.60066986084 sec
wclsFrameSaver: saving 892 traces tagged "gauss"
FrameSaver: q=18273.4 n=10132 tag=gauss
wclsFrameSaver: saving 871 traces tagged "wiener"
FrameSaver: q=28938.5 n=10284 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
20-Nov-2024 17:27:04 GMT Closed output file "000988_reco_data_2024-11-14T_093623Z_reco_data_2024-11-14T_142649Z_reco_data_2024-11-18T_130933Z.root"
20-Nov-2024 17:27:04 GMT Closed input file "root://xrootd.echo.stfc.ac.uk:1094/dune:/protodune/RSE/usertests/9f/51/000988_reco_data_2024-11-14T_093623Z_reco_data_2024-11-14T_142649Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 111.202 187.968 5101.69 172.63 163.558 1000
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000269022 0.00782431 0.702849 0.000880509 0.03363 1000
simulate:tpcrawdecoder:WireCellToolkit 111.115 187.589 5066.68 172.533 162.408 1000
simulate:opdigi:OpDetDigitizerDUNE 0.00034849 0.258647 31.7096 0.00380861 1.13415 1000
simulate:rns:RandomNumberSaver 3.1333e-05 7.0216e-05 0.00130982 6.24185e-05 8.29304e-05 1000
[art]:TriggerResults:TriggerResultInserter 1.2205e-05 2.68213e-05 0.000154676 2.5679e-05 1.16314e-05 1000
end_path:out1:RootOutput 5.448e-06 9.38053e-06 3.3529e-05 9.2505e-06 3.18247e-06 1000
end_path:out1:RootOutput(write) 0.0411288 0.112185 3.30423 0.0902549 0.141716 1000
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 8299.62 MB
Peak resident set size usage (VmHWM): 6399.8 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 94057842
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 816344180
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 106814471
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000988_reco_data_2024-11-14T_093623Z_reco_data_2024-11-14T_142649Z_reco_data_2024-11-18T_130933Z.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": 1732123624.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": 1731935634.0
},
"parents": [
{
"did": "usertests:000988_reco_data_2024-11-14T_093623Z_reco_data_2024-11-14T_142649Z.root"
}
]
}
===================
.:
total 2859984
-rw-r--r-- 1 pltdune01 pltdune 2852007866 Nov 20 17:27 000988_reco_data_2024-11-14T_093623Z_reco_data_2024-11-14T_142649Z_reco_data_2024-11-18T_130933Z.root
-rw-r--r-- 1 pltdune01 pltdune 38607111 Nov 20 17:27 000988_reco_data_2024-11-14T_093623Z_reco_data_2024-11-14T_142649Z_reco_2024-11-18T_130933Z.log
-rw-r--r-- 1 pltdune01 pltdune 37967521 Nov 20 17:27 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r-- 1 pltdune01 pltdune 6072 Nov 20 17:27 jobscript.log
-rw-r--r-- 1 pltdune01 pltdune 1115 Nov 20 17:27 000988_reco_data_2024-11-14T_093623Z_reco_data_2024-11-14T_142649Z_reco_data_2024-11-18T_130933Z.root.json
-rw-r--r-- 1 pltdune01 pltdune 930 Nov 20 17:27 000988_reco_data_2024-11-14T_093623Z_reco_data_2024-11-14T_142649Z_reco_data_2024-11-18T_130933Z.root.ext.json
-rw-r--r-- 1 pltdune01 pltdune 164 Nov 18 13:09 all-input-dids.txt
-rw-r--r-- 1 pltdune01 pltdune 143 Nov 20 17:27 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune01 pltdune 0 Nov 18 13:10 debugprod.log 