Jobsub ID 272059.4@justin-prod-sched01.dune.hep.ac.uk
Jobscript log (last 10,000 characters)
AFM detsim jobscript.
Input PFN = root://golias100.farm.particle.cz:1094/dpm/farm.particle.cz/home/dune/RSE/usertests/4e/8c/000447_reco_data_2024-10-07T_115611Z_reco_data_2024-10-08T_085249Z.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:57:01.683] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 90.94102 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::Digitizer : 90.86113 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::FrameFanin : 90.770996 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 90.73097 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::Reframer : 90.590965 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::Reframer : 90.56096 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::Reframer : 90.300896 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::Reframer : 89.89082 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::Reframer : 89.86081 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::Reframer : 89.81079 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::Reframer : 89.63076 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 89.60073 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::Reframer : 89.34069 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::Retagger : 89.19064 sec
[17:57:01.683] I [ timer ] Timer: WireCell::Gen::Reframer : 88.63055 sec
[17:57:01.683] I [ timer ] Timer: wcls::SimDepoSource : 81.95909 sec
[17:57:01.683] I [ timer ] Timer: Total node execution : 13780.327865600586 sec
wclsFrameSaver: saving 51653 traces tagged "gauss"
FrameSaver: q=5.18784e+07 n=1141850 tag=gauss
wclsFrameSaver: saving 62201 traces tagged "wiener"
FrameSaver: q=5.68085e+07 n=1071204 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
09-Oct-2024 17:57:30 CEST Closed output file "000447_reco_data_2024-10-07T_115611Z_reco_data_2024-10-08T_085249Z_reco_data_2024-10-09T_100646Z.root"
09-Oct-2024 17:57:30 CEST Closed input file "root://golias100.farm.particle.cz:1094/dpm/farm.particle.cz/home/dune/RSE/usertests/4e/8c/000447_reco_data_2024-10-07T_115611Z_reco_data_2024-10-08T_085249Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 85.5421 1906.66 8916.26 296.869 3136.81 11
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000577892 0.00311039 0.0162627 0.00193176 0.00421599 11
simulate:tpcrawdecoder:WireCellToolkit 84.6432 1899.54 8890.09 294.479 3128.34 11
simulate:opdigi:OpDetDigitizerDUNE 0.440007 6.16624 23.7818 1.99391 8.06028 11
simulate:rns:RandomNumberSaver 3.0601e-05 5.98122e-05 0.000208451 4.6041e-05 4.75104e-05 11
[art]:TriggerResults:TriggerResultInserter 1.135e-05 1.83892e-05 4.419e-05 1.575e-05 8.73864e-06 11
end_path:out1:RootOutput 5.85e-06 9.20727e-06 2.08e-05 6.66e-06 5.38545e-06 11
end_path:out1:RootOutput(write) 0.0648022 0.952505 3.03359 0.393698 1.02517 11
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 13489.9 MB
Peak resident set size usage (VmHWM): 10339.5 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 850664291
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 864480917
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 650935312
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000447_reco_data_2024-10-07T_115611Z_reco_data_2024-10-08T_085249Z_reco_data_2024-10-09T_100646Z.root
extractor_prod.py exit code 0
pdjson2metadata exit code 0
Metadata extraction succeeds
===Metadata JSON===
{
"metadata": {
"DUNE.campaign": "justIN.w3659s1",
"art.file_format_era": "ART_2011a",
"art.file_format_version": 15,
"art.first_event": 53,
"art.last_event": 904,
"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": 1728489450.0,
"core.event_count": 11,
"core.file_format": "artroot",
"core.file_type": "mc",
"core.first_event_number": 53,
"core.last_event_number": 904,
"core.run_type": "physics",
"core.runs": [
20000031
],
"core.runs_subruns": [
2000003100000
],
"core.start_time": 1728468534.0
},
"parents": [
{
"did": "usertests:000447_reco_data_2024-10-07T_115611Z_reco_data_2024-10-08T_085249Z.root"
}
]
}
===================
.:
total 2734488
-rw-r--r--. 1 duneprd np-comp 2799074257 Oct 9 17:57 000447_reco_data_2024-10-07T_115611Z_reco_data_2024-10-08T_085249Z_reco_data_2024-10-09T_100646Z.root
-rw-r--r--. 1 duneprd np-comp 511411 Oct 9 17:57 000447_reco_data_2024-10-07T_115611Z_reco_data_2024-10-08T_085249Z_reco_2024-10-09T_100646Z.log
-rw-r--r--. 1 duneprd np-comp 498317 Oct 9 17:57 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r--. 1 duneprd np-comp 6125 Oct 9 17:57 jobscript.log
-rw-r--r--. 1 duneprd np-comp 1113 Oct 9 17:57 000447_reco_data_2024-10-07T_115611Z_reco_data_2024-10-08T_085249Z_reco_data_2024-10-09T_100646Z.root.json
-rw-r--r--. 1 duneprd np-comp 928 Oct 9 17:57 000447_reco_data_2024-10-07T_115611Z_reco_data_2024-10-08T_085249Z_reco_data_2024-10-09T_100646Z.root.ext.json
-rw-r--r--. 1 duneprd np-comp 164 Oct 9 12:06 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp 162 Oct 9 17:57 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp 0 Oct 9 12:07 debugprod.log 