Jobsub ID 101168.13@justin-prod-sched02.dune.hep.ac.uk
Jobscript log (last 10,000 characters)
AFM detsim jobscript.
Input PFN = root://xrootd1.esc.qmul.ac.uk:1094//dune/RSE/usertests/11/15/000624_reco_data_2024-11-14T_093249Z_reco_data_2024-11-14T_135433Z.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 ===
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::Reframer : 53.718643 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::Reframer : 53.578682 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::Reframer : 53.448723 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::Reframer : 53.35872 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::Reframer : 52.978745 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::Reframer : 52.81877 sec
[23:10:41.382] I [ timer ] Timer: wcls::SimDepoSource : 33.980305 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::DumpFrames : 31.530626 sec
[23:10:41.382] I [ timer ] Timer: wcls::FrameSaver : 30.260597 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::FrameFanin : 30.140594 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 30.030592 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::FrameFanin : 29.810587 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::FrameFanin : 29.160572 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::Retagger : 29.06057 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 28.410555 sec
[23:10:41.382] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 28.370554 sec
[23:10:41.382] I [ timer ] Timer: Total node execution : 111485.74631690979 sec
wclsFrameSaver: saving 971 traces tagged "gauss"
FrameSaver: q=20248.8 n=11319 tag=gauss
wclsFrameSaver: saving 960 traces tagged "wiener"
FrameSaver: q=31551.1 n=11393 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
19-Nov-2024 23:10:44 GMT Closed output file "000624_reco_data_2024-11-14T_093249Z_reco_data_2024-11-14T_135433Z_reco_data_2024-11-18T_125608Z.root"
19-Nov-2024 23:10:44 GMT Closed input file "root://xrootd1.esc.qmul.ac.uk:1094//dune/RSE/usertests/11/15/000624_reco_data_2024-11-14T_093249Z_reco_data_2024-11-14T_135433Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 92.4546 123.126 354.975 119.824 28.0442 1000
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000225301 0.00143612 0.0320594 0.000640251 0.00256917 1000
simulate:tpcrawdecoder:WireCellToolkit 92.402 122.929 352.156 119.677 27.7544 1000
simulate:opdigi:OpDetDigitizerDUNE 0.000238264 0.0944946 3.2944 0.000721231 0.258887 1000
simulate:rns:RandomNumberSaver 2.5498e-05 4.12643e-05 0.000348531 3.6303e-05 2.40571e-05 1000
[art]:TriggerResults:TriggerResultInserter 1.0229e-05 1.55899e-05 0.000140251 1.4347e-05 1.01673e-05 1000
end_path:out1:RootOutput 4.288e-06 6.7482e-06 0.000122289 6.1115e-06 6.79832e-06 1000
end_path:out1:RootOutput(write) 0.0466128 0.100037 1.26629 0.0741544 0.105749 1000
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 3954.71 MB
Peak resident set size usage (VmHWM): 2283.32 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 870234881
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 297475884
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 546149192
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000624_reco_data_2024-11-14T_093249Z_reco_data_2024-11-14T_135433Z_reco_data_2024-11-18T_125608Z.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": 1732057844.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": 1731934762.0
},
"parents": [
{
"did": "usertests:000624_reco_data_2024-11-14T_093249Z_reco_data_2024-11-14T_135433Z.root"
}
]
}
===================
.:
total 2217080
-rw-r--r--. 1 job0028 job0028 2193662210 Nov 19 23:10 000624_reco_data_2024-11-14T_093249Z_reco_data_2024-11-14T_135433Z_reco_data_2024-11-18T_125608Z.root
-rw-r--r--. 1 job0028 job0028 38611083 Nov 19 23:10 000624_reco_data_2024-11-14T_093249Z_reco_data_2024-11-14T_135433Z_reco_2024-11-18T_125608Z.log
-rw-r--r--. 1 job0028 job0028 37972141 Nov 19 23:10 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r--. 1 job0028 job0028 6059 Nov 19 23:10 jobscript.log
-rw-r--r--. 1 job0028 job0028 1115 Nov 19 23:10 000624_reco_data_2024-11-14T_093249Z_reco_data_2024-11-14T_135433Z_reco_data_2024-11-18T_125608Z.root.json
-rw-r--r--. 1 job0028 job0028 930 Nov 19 23:10 000624_reco_data_2024-11-14T_093249Z_reco_data_2024-11-14T_135433Z_reco_data_2024-11-18T_125608Z.root.ext.json
-rw-r--r--. 1 job0028 job0028 164 Nov 18 12:56 all-input-dids.txt
-rw-r--r--. 1 job0028 job0028 133 Nov 19 23:10 justin-processed-pfns.txt
-rw-r--r--. 1 job0028 job0028 0 Nov 18 12:56 debugprod.log 